builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-049 starttime: 1449231877.24 results: success (0) buildid: 20151204025616 builduid: b5e2e9e5ae9647619d46229135accfda revision: b3f792eaa33835998fcb56187bd2343c16adb3ab ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.241752) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.242271) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.242657) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006307 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.267863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.268219) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.282283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.282722) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004603 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.333712) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.334083) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.334522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.334884) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 04:24:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2015-12-04 04:24:37 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.194517 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.542073) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.542444) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016947 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.597712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:37.598072) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b3f792eaa33835998fcb56187bd2343c16adb3ab --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b3f792eaa33835998fcb56187bd2343c16adb3ab --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 04:24:37,726 truncating revision to first 12 chars 2015-12-04 04:24:37,726 Setting DEBUG logging. 2015-12-04 04:24:37,726 attempt 1/10 2015-12-04 04:24:37,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b3f792eaa338?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 04:24:38,390 unpacking tar archive at: mozilla-central-b3f792eaa338/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969057 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:38.580473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:38.580842) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:38.591992) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:38.592407) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 04:24:38.592882) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-04 04:24:38.593205) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:24:38 INFO - MultiFileLogger online at 20151204 04:24:38 in /builds/slave/test 04:24:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:24:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:24:38 INFO - {'append_to_log': False, 04:24:38 INFO - 'base_work_dir': '/builds/slave/test', 04:24:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:24:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:24:38 INFO - 'branch': 'Firefox-Non-PGO', 04:24:38 INFO - 'buildbot_json_path': 'buildprops.json', 04:24:38 INFO - 'config_files': ('talos/linux_config.py',), 04:24:38 INFO - 'default_actions': ('clobber', 04:24:38 INFO - 'read-buildbot-config', 04:24:38 INFO - 'download-and-extract', 04:24:38 INFO - 'populate-webroot', 04:24:38 INFO - 'create-virtualenv', 04:24:38 INFO - 'install', 04:24:38 INFO - 'run-tests'), 04:24:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:24:38 INFO - 'download_minidump_stackwalk': True, 04:24:38 INFO - 'download_symbols': 'ondemand', 04:24:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:24:38 INFO - 'tooltool.py': '/tools/tooltool.py', 04:24:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:24:38 INFO - '/tools/misc-python/virtualenv.py')}, 04:24:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:24:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:24:38 INFO - 'installer_path': 'installer.exe', 04:24:38 INFO - 'log_level': 'info', 04:24:38 INFO - 'log_name': 'talos', 04:24:38 INFO - 'log_to_console': True, 04:24:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:24:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:24:38 INFO - 'opt_config_files': (), 04:24:38 INFO - 'pip_index': False, 04:24:38 INFO - 'sps_profile': False, 04:24:38 INFO - 'sps_profile_interval': 0, 04:24:38 INFO - 'suite': 'dromaeojs-e10s', 04:24:38 INFO - 'system_bits': '64', 04:24:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:24:38 INFO - 'title': 'talos-linux64-ix-049', 04:24:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:24:38 INFO - 'use_talos_json': True, 04:24:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:24:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:24:38 INFO - 'work_dir': 'build'} 04:24:38 INFO - ##### 04:24:38 INFO - ##### Running clobber step. 04:24:38 INFO - ##### 04:24:38 INFO - Running pre-action listener: _resource_record_pre_action 04:24:38 INFO - Running main action method: clobber 04:24:38 INFO - rmtree: /builds/slave/test/build 04:24:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:24:39 INFO - Running post-action listener: _resource_record_post_action 04:24:39 INFO - ##### 04:24:39 INFO - ##### Running read-buildbot-config step. 04:24:39 INFO - ##### 04:24:39 INFO - Running pre-action listener: _resource_record_pre_action 04:24:39 INFO - Running main action method: read_buildbot_config 04:24:39 INFO - Using buildbot properties: 04:24:39 INFO - { 04:24:39 INFO - "properties": { 04:24:39 INFO - "buildnumber": 111, 04:24:39 INFO - "product": "firefox", 04:24:39 INFO - "script_repo_revision": "production", 04:24:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:24:39 INFO - "repository": "", 04:24:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:24:39 INFO - "buildid": "20151204025616", 04:24:39 INFO - "slavename": "talos-linux64-ix-049", 04:24:39 INFO - "pgo_build": "False", 04:24:39 INFO - "basedir": "/builds/slave/test", 04:24:39 INFO - "project": "", 04:24:39 INFO - "platform": "ubuntu64_hw", 04:24:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:24:39 INFO - "slavebuilddir": "test", 04:24:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:24:39 INFO - "branch": "mozilla-central", 04:24:39 INFO - "repo_path": "mozilla-central", 04:24:39 INFO - "stage_platform": "linux64", 04:24:39 INFO - "builduid": "b5e2e9e5ae9647619d46229135accfda", 04:24:39 INFO - "revision": "b3f792eaa33835998fcb56187bd2343c16adb3ab" 04:24:39 INFO - }, 04:24:39 INFO - "sourcestamp": { 04:24:39 INFO - "repository": "", 04:24:39 INFO - "hasPatch": false, 04:24:39 INFO - "project": "", 04:24:39 INFO - "branch": "mozilla-central-linux64-talos", 04:24:39 INFO - "changes": [ 04:24:39 INFO - { 04:24:39 INFO - "category": null, 04:24:39 INFO - "files": [ 04:24:39 INFO - { 04:24:39 INFO - "url": null, 04:24:39 INFO - "name": "https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:24:39 INFO - } 04:24:39 INFO - ], 04:24:39 INFO - "repository": "", 04:24:39 INFO - "rev": "b3f792eaa33835998fcb56187bd2343c16adb3ab", 04:24:39 INFO - "who": "cbook@mozilla.com", 04:24:39 INFO - "when": 1449231872, 04:24:39 INFO - "number": 6743895, 04:24:39 INFO - "comments": "Bug 1230066 - Add missing STATUS_AUTH_REJECTED into enum BluetoothStatus,r=tzimmermann", 04:24:39 INFO - "project": "", 04:24:39 INFO - "at": "Fri 04 Dec 2015 04:24:32", 04:24:39 INFO - "branch": "mozilla-central-linux64-talos", 04:24:39 INFO - "revlink": "", 04:24:39 INFO - "properties": [ 04:24:39 INFO - [ 04:24:39 INFO - "buildid", 04:24:39 INFO - "20151204025616", 04:24:39 INFO - "Change" 04:24:39 INFO - ], 04:24:39 INFO - [ 04:24:39 INFO - "builduid", 04:24:39 INFO - "b5e2e9e5ae9647619d46229135accfda", 04:24:39 INFO - "Change" 04:24:39 INFO - ], 04:24:39 INFO - [ 04:24:39 INFO - "pgo_build", 04:24:39 INFO - "False", 04:24:39 INFO - "Change" 04:24:39 INFO - ] 04:24:39 INFO - ], 04:24:39 INFO - "revision": "b3f792eaa33835998fcb56187bd2343c16adb3ab" 04:24:39 INFO - } 04:24:39 INFO - ], 04:24:39 INFO - "revision": "b3f792eaa33835998fcb56187bd2343c16adb3ab" 04:24:39 INFO - } 04:24:39 INFO - } 04:24:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:24:39 INFO - Running post-action listener: _resource_record_post_action 04:24:39 INFO - ##### 04:24:39 INFO - ##### Running download-and-extract step. 04:24:39 INFO - ##### 04:24:39 INFO - Running pre-action listener: _resource_record_pre_action 04:24:39 INFO - Running main action method: download_and_extract 04:24:39 INFO - mkdir: /builds/slave/test/build/tests 04:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:39 INFO - https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:24:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/test_packages.json 04:24:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/test_packages.json 04:24:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:24:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:24:43 INFO - Downloaded 1302 bytes. 04:24:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:24:43 INFO - Using the following test package requirements: 04:24:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:24:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'jsshell-linux-x86_64.zip'], 04:24:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:24:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:24:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:24:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:24:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:24:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:24:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:24:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:24:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:43 INFO - https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:24:48 INFO - Downloaded 21790692 bytes. 04:24:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:24:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:24:49 INFO - Return code: 0 04:24:49 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:49 INFO - https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:24:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:24:51 INFO - Downloaded 21790692 bytes. 04:24:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:24:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:24:51 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:24:52 INFO - Return code: 0 04:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:52 INFO - https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:24:53 INFO - Downloaded 11132001 bytes. 04:24:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:24:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:24:53 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:24:53 INFO - Return code: 0 04:24:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:53 INFO - https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:24:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:24:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:24:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:24:54 INFO - Downloaded 57693371 bytes. 04:24:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:24:54 INFO - mkdir: /builds/slave/test/properties 04:24:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:24:54 INFO - Writing to file /builds/slave/test/properties/build_url 04:24:54 INFO - Contents: 04:24:54 INFO - build_url:https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:24:54 INFO - Running post-action listener: _resource_record_post_action 04:24:54 INFO - Running post-action listener: set_extra_try_arguments 04:24:54 INFO - ##### 04:24:54 INFO - ##### Running populate-webroot step. 04:24:54 INFO - ##### 04:24:54 INFO - Running pre-action listener: _resource_record_pre_action 04:24:54 INFO - Running main action method: populate_webroot 04:24:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:24:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:24:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:24:54 INFO - '../fennec_ids.txt'], 04:24:54 INFO - 'tests': ['tcheck2']}, 04:24:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:24:54 INFO - '--tppagecycles', 04:24:54 INFO - '7'], 04:24:54 INFO - 'tests': ['tsvgm']}}, 04:24:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:24:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:24:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:24:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:24:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:24:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'tests': ['damp', 'tps']}, 04:24:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['damp', 'tps']}, 04:24:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:24:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:24:54 INFO - 'other': {'tests': ['a11yr', 04:24:54 INFO - 'ts_paint', 04:24:54 INFO - 'tpaint', 04:24:54 INFO - 'sessionrestore', 04:24:54 INFO - 'sessionrestore_no_auto_restore']}, 04:24:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['a11yr', 04:24:54 INFO - 'ts_paint', 04:24:54 INFO - 'tpaint', 04:24:54 INFO - 'sessionrestore', 04:24:54 INFO - 'sessionrestore_no_auto_restore']}, 04:24:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['a11yr', 04:24:54 INFO - 'ts_paint', 04:24:54 INFO - 'tpaint', 04:24:54 INFO - 'sessionrestore', 04:24:54 INFO - 'sessionrestore_no_auto_restore']}, 04:24:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['a11yr', 04:24:54 INFO - 'ts_paint', 04:24:54 INFO - 'tpaint', 04:24:54 INFO - 'sessionrestore', 04:24:54 INFO - 'sessionrestore_no_auto_restore']}, 04:24:54 INFO - 'other_l64': {'tests': ['a11yr', 04:24:54 INFO - 'ts_paint', 04:24:54 INFO - 'tpaint', 04:24:54 INFO - 'sessionrestore', 04:24:54 INFO - 'sessionrestore_no_auto_restore']}, 04:24:54 INFO - 'other_nol64': {'tests': ['a11yr', 04:24:54 INFO - 'ts_paint', 04:24:54 INFO - 'tpaint', 04:24:54 INFO - 'sessionrestore', 04:24:54 INFO - 'sessionrestore_no_auto_restore']}, 04:24:54 INFO - 'svgr': {'tests': ['tsvgx', 04:24:54 INFO - 'tsvgr_opacity', 04:24:54 INFO - 'tart', 04:24:54 INFO - 'tscrollx', 04:24:54 INFO - 'cart']}, 04:24:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['tsvgx', 04:24:54 INFO - 'tsvgr_opacity', 04:24:54 INFO - 'tart', 04:24:54 INFO - 'tscrollx', 04:24:54 INFO - 'cart']}, 04:24:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'tests': ['tp5o']}, 04:24:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'talos_options': ['--e10s'], 04:24:54 INFO - 'tests': ['tp5o']}, 04:24:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'talos_options': ['--xperf_path', 04:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:54 INFO - 'tests': ['tp5n']}, 04:24:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:24:54 INFO - 'talos_options': ['--e10s', 04:24:54 INFO - '--xperf_path', 04:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:24:54 INFO - 'tests': ['tp5n']}}, 04:24:54 INFO - 'talos.zip': {'path': '', 04:24:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:24:54 INFO - Running post-action listener: _resource_record_post_action 04:24:54 INFO - ##### 04:24:54 INFO - ##### Running create-virtualenv step. 04:24:54 INFO - ##### 04:24:54 INFO - Running pre-action listener: _resource_record_pre_action 04:24:54 INFO - Running main action method: create_virtualenv 04:24:54 INFO - Creating virtualenv /builds/slave/test/build/venv 04:24:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:24:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:24:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:24:55 INFO - Using real prefix '/usr' 04:24:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:24:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:24:57 INFO - Installing pip.................done. 04:24:57 INFO - Return code: 0 04:24:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:24:57 INFO - Using env: {'DISPLAY': ':0', 04:24:57 INFO - 'HOME': '/home/cltbld', 04:24:57 INFO - 'LANG': 'en_US.UTF-8', 04:24:57 INFO - 'LANGUAGE': 'en_US:en', 04:24:57 INFO - 'LOGNAME': 'cltbld', 04:24:57 INFO - 'MAIL': '/var/mail/cltbld', 04:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:57 INFO - 'MOZ_NO_REMOTE': '1', 04:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:57 INFO - 'NO_EM_RESTART': '1', 04:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:57 INFO - 'PWD': '/builds/slave/test', 04:24:57 INFO - 'SHELL': '/bin/bash', 04:24:57 INFO - 'SHLVL': '1', 04:24:57 INFO - 'TERM': 'linux', 04:24:57 INFO - 'TMOUT': '86400', 04:24:57 INFO - 'USER': 'cltbld', 04:24:57 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:57 INFO - '_': '/tools/buildbot/bin/python'} 04:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:24:58 INFO - Cleaning up... 04:24:58 INFO - Return code: 0 04:24:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:24:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:24:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:24:58 INFO - Using env: {'DISPLAY': ':0', 04:24:58 INFO - 'HOME': '/home/cltbld', 04:24:58 INFO - 'LANG': 'en_US.UTF-8', 04:24:58 INFO - 'LANGUAGE': 'en_US:en', 04:24:58 INFO - 'LOGNAME': 'cltbld', 04:24:58 INFO - 'MAIL': '/var/mail/cltbld', 04:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:58 INFO - 'MOZ_NO_REMOTE': '1', 04:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:58 INFO - 'NO_EM_RESTART': '1', 04:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:58 INFO - 'PWD': '/builds/slave/test', 04:24:58 INFO - 'SHELL': '/bin/bash', 04:24:58 INFO - 'SHLVL': '1', 04:24:58 INFO - 'TERM': 'linux', 04:24:58 INFO - 'TMOUT': '86400', 04:24:58 INFO - 'USER': 'cltbld', 04:24:58 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:58 INFO - '_': '/tools/buildbot/bin/python'} 04:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:58 INFO - Downloading/unpacking psutil>=0.7.1 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:24:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:25:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:25:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:25:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:00 INFO - Installing collected packages: psutil 04:25:00 INFO - Running setup.py install for psutil 04:25:00 INFO - building 'psutil._psutil_linux' extension 04:25:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:25:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:25:00 INFO - building 'psutil._psutil_posix' extension 04:25:00 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:25:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:25:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:25:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:25:00 INFO - Successfully installed psutil 04:25:00 INFO - Cleaning up... 04:25:00 INFO - Return code: 0 04:25:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:25:00 INFO - Using env: {'DISPLAY': ':0', 04:25:00 INFO - 'HOME': '/home/cltbld', 04:25:00 INFO - 'LANG': 'en_US.UTF-8', 04:25:00 INFO - 'LANGUAGE': 'en_US:en', 04:25:00 INFO - 'LOGNAME': 'cltbld', 04:25:00 INFO - 'MAIL': '/var/mail/cltbld', 04:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:00 INFO - 'MOZ_NO_REMOTE': '1', 04:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:00 INFO - 'NO_EM_RESTART': '1', 04:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:00 INFO - 'PWD': '/builds/slave/test', 04:25:00 INFO - 'SHELL': '/bin/bash', 04:25:00 INFO - 'SHLVL': '1', 04:25:00 INFO - 'TERM': 'linux', 04:25:00 INFO - 'TMOUT': '86400', 04:25:00 INFO - 'USER': 'cltbld', 04:25:00 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:00 INFO - '_': '/tools/buildbot/bin/python'} 04:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:25:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:25:02 INFO - Installing collected packages: mozsystemmonitor 04:25:02 INFO - Running setup.py install for mozsystemmonitor 04:25:02 INFO - Successfully installed mozsystemmonitor 04:25:02 INFO - Cleaning up... 04:25:02 INFO - Return code: 0 04:25:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:25:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:25:02 INFO - Using env: {'DISPLAY': ':0', 04:25:02 INFO - 'HOME': '/home/cltbld', 04:25:02 INFO - 'LANG': 'en_US.UTF-8', 04:25:02 INFO - 'LANGUAGE': 'en_US:en', 04:25:02 INFO - 'LOGNAME': 'cltbld', 04:25:02 INFO - 'MAIL': '/var/mail/cltbld', 04:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:02 INFO - 'MOZ_NO_REMOTE': '1', 04:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:02 INFO - 'NO_EM_RESTART': '1', 04:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:02 INFO - 'PWD': '/builds/slave/test', 04:25:02 INFO - 'SHELL': '/bin/bash', 04:25:02 INFO - 'SHLVL': '1', 04:25:02 INFO - 'TERM': 'linux', 04:25:02 INFO - 'TMOUT': '86400', 04:25:02 INFO - 'USER': 'cltbld', 04:25:02 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:02 INFO - '_': '/tools/buildbot/bin/python'} 04:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:25:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:25:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:25:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:05 INFO - Downloading docopt-0.6.1.tar.gz 04:25:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:25:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:25:05 INFO - Running setup.py install for blobuploader 04:25:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:25:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:25:05 INFO - Running setup.py install for requests 04:25:05 INFO - Running setup.py install for docopt 04:25:05 INFO - Successfully installed blobuploader requests docopt 04:25:05 INFO - Cleaning up... 04:25:05 INFO - Return code: 0 04:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:05 INFO - Using env: {'DISPLAY': ':0', 04:25:05 INFO - 'HOME': '/home/cltbld', 04:25:05 INFO - 'LANG': 'en_US.UTF-8', 04:25:05 INFO - 'LANGUAGE': 'en_US:en', 04:25:05 INFO - 'LOGNAME': 'cltbld', 04:25:05 INFO - 'MAIL': '/var/mail/cltbld', 04:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:05 INFO - 'MOZ_NO_REMOTE': '1', 04:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:05 INFO - 'NO_EM_RESTART': '1', 04:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:05 INFO - 'PWD': '/builds/slave/test', 04:25:05 INFO - 'SHELL': '/bin/bash', 04:25:05 INFO - 'SHLVL': '1', 04:25:05 INFO - 'TERM': 'linux', 04:25:05 INFO - 'TMOUT': '86400', 04:25:05 INFO - 'USER': 'cltbld', 04:25:05 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:05 INFO - '_': '/tools/buildbot/bin/python'} 04:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:06 INFO - Running setup.py (path:/tmp/pip-uQsvxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:06 INFO - Running setup.py (path:/tmp/pip-2q8TwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:06 INFO - Running setup.py (path:/tmp/pip-mPp52t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:06 INFO - Running setup.py (path:/tmp/pip-yJ2BLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:06 INFO - Running setup.py (path:/tmp/pip-Lrjr2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:06 INFO - Running setup.py (path:/tmp/pip-5fxo7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:06 INFO - Running setup.py (path:/tmp/pip-OvoCCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:06 INFO - Running setup.py (path:/tmp/pip-jJMGcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:06 INFO - Running setup.py (path:/tmp/pip-PR9I5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:06 INFO - Running setup.py (path:/tmp/pip-0l1lf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:06 INFO - Running setup.py (path:/tmp/pip-NmjQjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:06 INFO - Running setup.py (path:/tmp/pip-qy4MiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:07 INFO - Running setup.py (path:/tmp/pip-HR7sGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:07 INFO - Running setup.py (path:/tmp/pip-jvHFPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:07 INFO - Running setup.py (path:/tmp/pip-DAA56A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:07 INFO - Running setup.py (path:/tmp/pip-Pu36rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:07 INFO - Running setup.py (path:/tmp/pip-Z_CRMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:25:07 INFO - Running setup.py install for manifestparser 04:25:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:25:07 INFO - Running setup.py install for mozcrash 04:25:07 INFO - Running setup.py install for mozdebug 04:25:07 INFO - Running setup.py install for mozdevice 04:25:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:25:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:25:07 INFO - Running setup.py install for mozfile 04:25:07 INFO - Running setup.py install for mozhttpd 04:25:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:25:07 INFO - Running setup.py install for mozinfo 04:25:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Running setup.py install for mozInstall 04:25:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Running setup.py install for mozleak 04:25:08 INFO - Running setup.py install for mozlog 04:25:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Running setup.py install for moznetwork 04:25:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Running setup.py install for mozprocess 04:25:08 INFO - Running setup.py install for mozprofile 04:25:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Running setup.py install for mozrunner 04:25:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:25:08 INFO - Running setup.py install for mozscreenshot 04:25:08 INFO - Running setup.py install for moztest 04:25:09 INFO - Running setup.py install for mozversion 04:25:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:25:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:25:09 INFO - Cleaning up... 04:25:09 INFO - Return code: 0 04:25:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:25:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:09 INFO - Using env: {'DISPLAY': ':0', 04:25:09 INFO - 'HOME': '/home/cltbld', 04:25:09 INFO - 'LANG': 'en_US.UTF-8', 04:25:09 INFO - 'LANGUAGE': 'en_US:en', 04:25:09 INFO - 'LOGNAME': 'cltbld', 04:25:09 INFO - 'MAIL': '/var/mail/cltbld', 04:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:09 INFO - 'MOZ_NO_REMOTE': '1', 04:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:09 INFO - 'NO_EM_RESTART': '1', 04:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:09 INFO - 'PWD': '/builds/slave/test', 04:25:09 INFO - 'SHELL': '/bin/bash', 04:25:09 INFO - 'SHLVL': '1', 04:25:09 INFO - 'TERM': 'linux', 04:25:09 INFO - 'TMOUT': '86400', 04:25:09 INFO - 'USER': 'cltbld', 04:25:09 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:09 INFO - '_': '/tools/buildbot/bin/python'} 04:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:25:09 INFO - Running setup.py (path:/tmp/pip-fjLgWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:25:09 INFO - Running setup.py (path:/tmp/pip-WTFSWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:25:09 INFO - Running setup.py (path:/tmp/pip-LTwXUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:25:09 INFO - Running setup.py (path:/tmp/pip-8w5k2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:25:09 INFO - Running setup.py (path:/tmp/pip-zQ5nye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:25:09 INFO - Running setup.py (path:/tmp/pip-kexM3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:25:09 INFO - Running setup.py (path:/tmp/pip-6aIS_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:25:09 INFO - Running setup.py (path:/tmp/pip-a4CQju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:25:09 INFO - Running setup.py (path:/tmp/pip-TPydq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:25:10 INFO - Running setup.py (path:/tmp/pip-7Yq6th-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:25:10 INFO - Running setup.py (path:/tmp/pip-_yI3z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:25:10 INFO - Running setup.py (path:/tmp/pip-ZZFPgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:25:10 INFO - Running setup.py (path:/tmp/pip-JVQCjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:25:10 INFO - Running setup.py (path:/tmp/pip-Tho73Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:10 INFO - Running setup.py (path:/tmp/pip-4JvvSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:25:10 INFO - Running setup.py (path:/tmp/pip-MB3HRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:25:10 INFO - Running setup.py (path:/tmp/pip-Barr0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:25:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:12 INFO - Downloading blessings-1.5.1.tar.gz 04:25:12 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:25:12 INFO - Installing collected packages: blessings 04:25:12 INFO - Running setup.py install for blessings 04:25:12 INFO - Successfully installed blessings 04:25:12 INFO - Cleaning up... 04:25:12 INFO - Return code: 0 04:25:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:12 INFO - Reading from file tmpfile_stdout 04:25:12 INFO - Current package versions: 04:25:12 INFO - argparse == 1.2.1 04:25:12 INFO - blessings == 1.5.1 04:25:12 INFO - blobuploader == 1.2.4 04:25:12 INFO - docopt == 0.6.1 04:25:12 INFO - manifestparser == 1.1 04:25:12 INFO - mozInstall == 1.12 04:25:12 INFO - mozcrash == 0.16 04:25:12 INFO - mozdebug == 0.1 04:25:12 INFO - mozdevice == 0.47 04:25:12 INFO - mozfile == 1.2 04:25:12 INFO - mozhttpd == 0.7 04:25:12 INFO - mozinfo == 0.9 04:25:12 INFO - mozleak == 0.1 04:25:12 INFO - mozlog == 3.1 04:25:12 INFO - moznetwork == 0.27 04:25:12 INFO - mozprocess == 0.22 04:25:12 INFO - mozprofile == 0.27 04:25:12 INFO - mozrunner == 6.11 04:25:12 INFO - mozscreenshot == 0.1 04:25:12 INFO - mozsystemmonitor == 0.0 04:25:12 INFO - moztest == 0.7 04:25:12 INFO - mozversion == 1.4 04:25:12 INFO - psutil == 3.1.1 04:25:12 INFO - requests == 1.2.3 04:25:12 INFO - wsgiref == 0.1.2 04:25:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:25:12 INFO - Using env: {'DISPLAY': ':0', 04:25:12 INFO - 'HOME': '/home/cltbld', 04:25:12 INFO - 'LANG': 'en_US.UTF-8', 04:25:12 INFO - 'LANGUAGE': 'en_US:en', 04:25:12 INFO - 'LOGNAME': 'cltbld', 04:25:12 INFO - 'MAIL': '/var/mail/cltbld', 04:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:12 INFO - 'MOZ_NO_REMOTE': '1', 04:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:12 INFO - 'NO_EM_RESTART': '1', 04:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:12 INFO - 'PWD': '/builds/slave/test', 04:25:12 INFO - 'SHELL': '/bin/bash', 04:25:12 INFO - 'SHLVL': '1', 04:25:12 INFO - 'TERM': 'linux', 04:25:12 INFO - 'TMOUT': '86400', 04:25:12 INFO - 'USER': 'cltbld', 04:25:12 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:12 INFO - '_': '/tools/buildbot/bin/python'} 04:25:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:25:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:25:12 INFO - Cleaning up... 04:25:12 INFO - Return code: 0 04:25:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:25:12 INFO - Using env: {'DISPLAY': ':0', 04:25:12 INFO - 'HOME': '/home/cltbld', 04:25:12 INFO - 'LANG': 'en_US.UTF-8', 04:25:12 INFO - 'LANGUAGE': 'en_US:en', 04:25:12 INFO - 'LOGNAME': 'cltbld', 04:25:12 INFO - 'MAIL': '/var/mail/cltbld', 04:25:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:12 INFO - 'MOZ_NO_REMOTE': '1', 04:25:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:12 INFO - 'NO_EM_RESTART': '1', 04:25:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:12 INFO - 'PWD': '/builds/slave/test', 04:25:12 INFO - 'SHELL': '/bin/bash', 04:25:12 INFO - 'SHLVL': '1', 04:25:12 INFO - 'TERM': 'linux', 04:25:12 INFO - 'TMOUT': '86400', 04:25:12 INFO - 'USER': 'cltbld', 04:25:12 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:12 INFO - '_': '/tools/buildbot/bin/python'} 04:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:13 INFO - Downloading/unpacking jsonschema 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:25:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:25:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:25:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:25:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:25:15 INFO - warning: no files found matching '*.txt' 04:25:15 INFO - no previously-included directories found matching 'build' 04:25:15 INFO - no previously-included directories found matching 'dist' 04:25:15 INFO - no previously-included directories found matching '.git*' 04:25:15 INFO - Installing collected packages: jsonschema, functools32 04:25:15 INFO - Running setup.py install for functools32 04:25:15 INFO - warning: no files found matching '*.txt' 04:25:15 INFO - no previously-included directories found matching 'build' 04:25:15 INFO - no previously-included directories found matching 'dist' 04:25:15 INFO - no previously-included directories found matching '.git*' 04:25:15 INFO - Successfully installed jsonschema functools32 04:25:15 INFO - Cleaning up... 04:25:15 INFO - Return code: 0 04:25:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:25:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:25:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:25:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ed1775f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24cd240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:25:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:25:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:25:15 INFO - Using env: {'DISPLAY': ':0', 04:25:15 INFO - 'HOME': '/home/cltbld', 04:25:15 INFO - 'LANG': 'en_US.UTF-8', 04:25:15 INFO - 'LANGUAGE': 'en_US:en', 04:25:15 INFO - 'LOGNAME': 'cltbld', 04:25:15 INFO - 'MAIL': '/var/mail/cltbld', 04:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:15 INFO - 'MOZ_NO_REMOTE': '1', 04:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:15 INFO - 'NO_EM_RESTART': '1', 04:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:15 INFO - 'PWD': '/builds/slave/test', 04:25:15 INFO - 'SHELL': '/bin/bash', 04:25:15 INFO - 'SHLVL': '1', 04:25:15 INFO - 'TERM': 'linux', 04:25:15 INFO - 'TMOUT': '86400', 04:25:15 INFO - 'USER': 'cltbld', 04:25:15 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:15 INFO - '_': '/tools/buildbot/bin/python'} 04:25:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:25:15 INFO - Downloading/unpacking flake8 04:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:25:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:25:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:25:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:25:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:25:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:25:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:25:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:25:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:17 INFO - no previously-included directories found matching 'docs/_build' 04:25:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:25:17 INFO - Running setup.py install for pep8 04:25:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:25:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:25:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:25:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:25:17 INFO - no previously-included directories found matching 'docs/_build' 04:25:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:25:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:25:18 INFO - Cleaning up... 04:25:18 INFO - Return code: 0 04:25:18 INFO - Running post-action listener: _resource_record_post_action 04:25:18 INFO - Running post-action listener: _start_resource_monitoring 04:25:18 INFO - Starting resource monitoring. 04:25:18 INFO - ##### 04:25:18 INFO - ##### Running install step. 04:25:18 INFO - ##### 04:25:18 INFO - Running pre-action listener: _resource_record_pre_action 04:25:18 INFO - Running main action method: install 04:25:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:25:18 INFO - Reading from file tmpfile_stdout 04:25:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:25:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:25:18 INFO - Reading from file tmpfile_stdout 04:25:18 INFO - Output received: 04:25:18 INFO - Usage: mozinstall [options] installer 04:25:18 INFO - Options: 04:25:18 INFO - -h, --help show this help message and exit 04:25:18 INFO - -d DEST, --destination=DEST 04:25:18 INFO - Directory to install application into. [default: 04:25:18 INFO - "/builds/slave/test"] 04:25:18 INFO - --app=APP Application being installed. [default: firefox] 04:25:18 INFO - mkdir: /builds/slave/test/build/application 04:25:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:25:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:25:32 INFO - Reading from file tmpfile_stdout 04:25:32 INFO - Output received: 04:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:25:32 INFO - Running post-action listener: _resource_record_post_action 04:25:32 INFO - ##### 04:25:32 INFO - ##### Running run-tests step. 04:25:32 INFO - ##### 04:25:32 INFO - Running pre-action listener: _resource_record_pre_action 04:25:32 INFO - Running main action method: run_tests 04:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:25:32 INFO - Python 2.7.3 04:25:32 INFO - Return code: 0 04:25:32 INFO - grabbing minidump binary from tooltool 04:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:25:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255c0b0>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:25:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:25:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:25:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:25:32 INFO - Return code: 0 04:25:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:25:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:25:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:25:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:25:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:25:33 INFO - Return code: 0 04:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test/build 04:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 04:25:33 INFO - Using env: {'DISPLAY': ':0', 04:25:33 INFO - 'HOME': '/home/cltbld', 04:25:33 INFO - 'LANG': 'en_US.UTF-8', 04:25:33 INFO - 'LANGUAGE': 'en_US:en', 04:25:33 INFO - 'LOGNAME': 'cltbld', 04:25:33 INFO - 'MAIL': '/var/mail/cltbld', 04:25:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:25:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:25:33 INFO - 'MOZ_NO_REMOTE': '1', 04:25:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:25:33 INFO - 'NO_EM_RESTART': '1', 04:25:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:25:33 INFO - 'PWD': '/builds/slave/test', 04:25:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:25:33 INFO - 'SHELL': '/bin/bash', 04:25:33 INFO - 'SHLVL': '1', 04:25:33 INFO - 'TERM': 'linux', 04:25:33 INFO - 'TMOUT': '86400', 04:25:33 INFO - 'USER': 'cltbld', 04:25:33 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781', 04:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:25:33 INFO - '_': '/tools/buildbot/bin/python'} 04:25:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 04:25:34 INFO - mozversion INFO | application_buildid: 20151204025616 04:25:34 INFO - mozversion INFO | application_changeset: b3f792eaa33835998fcb56187bd2343c16adb3ab 04:25:34 INFO - mozversion INFO | application_display_name: Nightly 04:25:34 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:25:34 INFO - mozversion INFO | application_name: Firefox 04:25:34 INFO - mozversion INFO | application_remotingname: firefox 04:25:34 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:25:34 INFO - mozversion INFO | application_vendor: Mozilla 04:25:34 INFO - mozversion INFO | application_version: 45.0a1 04:25:34 INFO - mozversion INFO | platform_buildid: 20151204025616 04:25:34 INFO - mozversion INFO | platform_changeset: b3f792eaa33835998fcb56187bd2343c16adb3ab 04:25:34 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:25:34 INFO - mozversion INFO | platform_version: 45.0a1 04:25:34 INFO - 2015-12-04 04:25:34,139 DEBUG : using testdate: 1449231934 04:25:34 INFO - 2015-12-04 04:25:34,139 DEBUG : actual date: 1449231934 04:25:34 INFO - 2015-12-04 04:25:34,149 INFO : starting webserver on 'localhost:42487' 04:25:34 INFO - 2015-12-04 04:25:34,150 INFO : Starting test suite talos-linux64-ix-049.e 04:25:34 INFO - 2015-12-04 04:25:34,150 INFO : Starting test dromaeo_css 04:25:34 INFO - 2015-12-04 04:25:34,150 DEBUG : operating with platform_type : linux_ 04:25:34 INFO - 2015-12-04 04:25:34,151 INFO : Initialising browser for dromaeo_css test... 04:25:34 INFO - 2015-12-04 04:25:34,166 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCF2RH/profile http://localhost:42487/getInfo.html 04:25:39 INFO - 2015-12-04 04:25:39,189 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:25:39 INFO - 2015-12-04 04:25:39,190 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:25:39 INFO - 2015-12-04 04:25:39,190 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:25:39 INFO - 2015-12-04 04:25:39,190 DEBUG : BROWSER_OUTPUT: __metrics 04:25:39 INFO - 2015-12-04 04:25:39,731 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:25:40 INFO - 2015-12-04 04:25:40,677 INFO : Browser initialized. 04:25:40 INFO - 2015-12-04 04:25:40,678 INFO : Running cycle 1/1 for dromaeo_css test... 04:25:40 INFO - 2015-12-04 04:25:40,678 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDCF2RH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:25:52 INFO - 2015-12-04 04:25:52,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 143179776 04:25:52 INFO - 2015-12-04 04:25:52,664 DEBUG : BROWSER_OUTPUT: 04:26:42 INFO - 2015-12-04 04:26:42,277 DEBUG : BROWSER_OUTPUT: 1449232002276 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:28:53 INFO - 2015-12-04 04:28:53,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42487/tests/dromaeo/cssquery-ext.html) 04:28:55 INFO - 2015-12-04 04:28:55,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 147005440 04:28:55 INFO - 2015-12-04 04:28:55,150 DEBUG : BROWSER_OUTPUT: 04:31:57 INFO - 2015-12-04 04:31:57,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-ext.html (next: http://localhost:42487/tests/dromaeo/cssquery-jquery.html) 04:31:57 INFO - 2015-12-04 04:31:57,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 145616896 04:31:57 INFO - 2015-12-04 04:31:57,919 DEBUG : BROWSER_OUTPUT: 04:34:59 INFO - 2015-12-04 04:34:59,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42487/tests/dromaeo/cssquery-mootools.html) 04:35:00 INFO - 2015-12-04 04:35:00,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 145465344 04:35:00 INFO - 2015-12-04 04:35:00,329 DEBUG : BROWSER_OUTPUT: 04:38:02 INFO - 2015-12-04 04:38:02,099 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42487/tests/dromaeo/cssquery-prototype.html) 04:38:02 INFO - 2015-12-04 04:38:02,705 DEBUG : BROWSER_OUTPUT: RSS: Main: 144457728 04:38:02 INFO - 2015-12-04 04:38:02,705 DEBUG : BROWSER_OUTPUT: 04:41:05 INFO - 2015-12-04 04:41:05,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42487/tests/dromaeo/cssquery-yui.html) 04:41:05 INFO - 2015-12-04 04:41:05,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 145125376 04:41:05 INFO - 2015-12-04 04:41:05,815 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/dromaeo/cssquery-yui.html (next: http://localhost:42487/tests/dromaeo/cssquery-dojo.html) 04:44:08 INFO - 2015-12-04 04:44:08,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 147329024 04:44:08 INFO - 2015-12-04 04:44:08,586 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,586 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:44:08 INFO - 2015-12-04 04:44:08,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:44:08 INFO - 2015-12-04 04:44:08,587 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:44:08 INFO - 2015-12-04 04:44:08,587 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:44:08 INFO - 2015-12-04 04:44:08,588 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2656.667916510436;2711.2137480130764;2734.7265273472653;2736.1381164933046;2750.2849259192612;4548.204064288753;4756.762161891905;4779.9283010754825;4797.880052998677;4800.9519904800945;4595.172868883599;4628.1669299526075;4647.604953578942;4700.835470758524;4738.123447162268;4305.590968857953;4337.049581798604;4352.455943007124;4442.289233722605;4542.704724192933;4452.332150177467;4468.4414448193975;4490.8877278067985;4537.546245375469;4565.018521017981;4143.523494798092;4265.9786701066605;4350.630196433275;4461.263891457906;4486.192485352635;4393.055493068973;4414.183376075436;4426.468823741139;4432.711873728197;4455.131249406367;4119.691023173244;4409.713368631029;4411.360352748833;4421.027373977719;4465.419495465601;4550.408446901914;4608.423947006624;4667.486576476585;4678.251479763221;4683.765811709435;5150.27896094547;5155.484451554852;5175.741212939376;5177.948220517822;5231.921521177185;4781.187198176319;4968.975155124237;5177.896442071137;5199.766010529535;5209.791608335662;4735.431748190239;4788.377510923558;4823.324734537167;4837.250226214942;4868.926966095476;5305.761240744176;5331.333583302087;5333.86665333362;5340.546053585411;5376.865578360494;4853.4418541867435;4951.084049450863;4958.330625365602;5099.796008159707;5111.3355263815465;5147.56245719118;5151;5166.070107380632;5166.715830629276;5194.92207616886;5113.974430127825;5115.18157094863;5121.8463446096675;5137.33214682089;5176.456472070454;4786.6888652238185;4868.707877527359;4877.024595080927;4896.853094407174;5106.361704786902;4131.5455299916985;4150.522689890641;4153.522344930372;4223.598758118035;4230.957690423056;3704.7962362070343;3705.6294370562728;3710.777353358807;3719.460678201646;3751.5685696144747;4177.310743727251;4365.039691267916;4372.4315838941375;4381.123775244963;4424.491183513873;5019.14674505335;5040.092783299041;5128.640995130305;5130.563902068366;5190.688558686491;4368.060866913565;4373.671974601918;4405.691601587858;4413.073254616503;4438.245498265303;4352.7823608819435;4467.173572889026;4562.58936695699;4565;4575.771211439414;4744.430668319824;4761.833335833229;4772.117158325721;4807.351007613927;4860.465348811557;5133.845984620468;5213.191955246943;5217.321748172713;5220.895582088413;5269.841904742864;4609.354690343422;4822.614190864652;4898.436679781728;4899.064012056805;4908.9263661045825;4882.072406242803;4953.678010929278;5026.974865125651;5029.84910452687;5075.568576671024;5152.613553983391;5213.646605084645;5216.37403511581;5258;5263.868403289948;4851.539103785135;4977.552020318189;5034.622403319839;5072.5688316493515;5076.36545431821;4889.975550122226;4949.950500494949;4966.106100901872;4974.328465657235;5013.924791128063;4872.098661747588;4878.975605121952;4888.877778055577;4899.363082799213;4962.106820772296;4829.2997515359375;4869.147899117569;4935.728534930613;5050.141475949024;5099.36257967754;4879.243717223836;4934.087193869145;4939.851804445872;4949.678270912379;4963.404391473046 04:44:08 INFO - 2015-12-04 04:44:08,589 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.8612846788303;562.3308263166833;570.5806232419171;576.8327185116315;576.9884602307953;36496.08759781007;37134.81432592837;37262.44106338404;37428.625713742855;37501;40157.59842401575;40663;40765.7961710191;40814.59185408145;41081.17837643245;7861.135275119746;8055.718049868256;8056.597170141499;8079.232472915063;8101.4328996970235;7867.291943725064;7966.203379662045;7980;8005.239502247277;8015.398845086613;7877.645505952246;7900.762977110696;7936.206379362046;7948.682052717884;7952.045754509467;7904.565248911307;7992.3606111510935;7998.400119990994;8001.519908805491;8018.318442932299;7816.64825082867;7871;7910.169432209593;7943.324817390471;7951.085625153066;36747.81626091879;37323.25353492942;37497;37518.37371384004;37550.62449375526;2742.5474796658527;2744.6294750208667;2834.588984597222;2908.7382135607686;3338.3490219407227;28511;28669.42661146786;28791.280217994718;28858.711412885812;29086;3375.3249350130072;3387.627360990289;3452.3613131570487;3456.084137703511;3541.451075083366;218279;219175.9999999984;219492;219636;220530;51810;52824.735876320374;55947;56711;61203.69398152981;57236.42763572394;58504.4149558499;58652.4134758647;58654.706726466946;58748.706256468446;12106.455209515592;12184.695382615506;12245.204061736136;12267.631971040882;12312;9058.773530661787;9121.726348209564;9159.95420022909;9163.633454661738;9174.541272936327;18947.81052189488;19193.32823351204;19214.231430742613;19314.71027934582;19418.223271069;7652.80867978305;7774.183710710294;7825.217478252243;7829.804254893559;7867.370610351159;818.7298191596877;915.697819719491;925.6713866577403;1007.8034783217203;1022.1873610479538;26004.479910401686;26031;26239.212823615322;26289.868550657124;26467.338316542242;901.6438506789781;985.2216748768536;991.3556188477403;1028.9864483483761;1062.3360399750156;13717.45130194801;13775.726158641859;13883.236421996686;14019.439222430989;14069.929650351683;568780;577643;582502;584258;585179;48328;48843.511564884604;48876.266855997186;48941.51058489441;49187;1207.4687137659403;1229.3853073463267;1230.1511956749814;1230.4340003598265;1233.2662066070852;26726;26807.597886032116;27292.454150916474;27389.589156162274;29512.852435737685;43186.35220471758;43743.34384984292;43792;43792.78103609462;43803;254561;257210;257955;258145;259654;39040.2191956165;41942.16115677731;42271;42410.15179696451;42832.78583607062;39853.20293594054;39959.400608990305;40449.59550404576;41215.96960076022;41235.38146927738;34016.14959626029;34604.82697586496;34643.82678086694;34819.82590087033;35097.29805403929;34707.82646086753;34846.825765871006;35110;36329.81835090808;38927.2214555713;34686.47970280498;34933.47599785955;35214.47178292379;35289.64710352864;35399.115022123624;29723.405531889675;31197.532037019915;31822.40887955639;31854.522182166824;31990.20024499313;24137.879310603334;24188.153414630404;24361.26916192517;24439.26682199537;24475.632865506675 04:44:08 INFO - 2015-12-04 04:44:08,591 DEBUG : BROWSER_OUTPUT: |2;jquery.html;310.01415498714096;322.86762427404767;324.2089302102869;324.8992812228209;327.692506897479;15834.683306333895;15869.682606347866;16200.432984845518;16322.265498052586;16538.66922661546;13993.230372329517;14100.858991410083;14131.858681413183;14156.292185390716;14192.219427931459;4563.520830312819;4567.88580285493;4651.837185698501;4667.509911459299;4669.1362098011805;4590.104929538741;4626.236670949289;4626.69926454781;4646.790894409743;4674.953250467503;3303.207230264743;4644.790984405709;4660.1844677181525;5406.378266499344;5729.770809167629;5617.831465056055;5636.605437619368;5703.686297253649;5711.086226203808;5720.11338242573;4953.083679519301;5037.848864534069;5043.193089105725;5065.6200784941275;5066.316047333637;11054.281471704313;11266.267692599955;11292.774144517063;11434.599789007429;11436.71408214793;1756.7277072053853;1815.7367181758702;1894.5831916978243;1907.094130288102;1912.1968773115325;8979.371443998923;9414.29392795543;9419.387739796892;11887;12698.73012698732;414.81126087630355;822.9958850205711;1763.5943732941496;1777.6977913754563;1811.8056698742369;54048;55854;56370;56652.43347566513;56705.43294567043;9571.37786043905;9693.660721874701;9721.513924303756;9753.732014838026;9768.560414781352;12215.083868709704;12216.450259738333;12228.266304021787;12231.755364892651;12264.141510094209;6318.905216421757;6423.229212494531;6431.389018043372;6433.8713225736155;6434.227892652912;5753.971230143822;5895.528357731371;6103.816885493442;6104.17593624855;6160.168377269011;4105.630493255621;4127.360259159835;4140.627343539096;4174.749515029047;4196.076863090116;1703.4378655043806;1722.7846519185102;1727;1777.1558509707786;1791.3551121596215;372.3762697481707;377.2436265288135;386.7911327882912;917.3761841947406;997.8453339732208;9968.601255949681;10080.135384002904;10173.643922462677;10208.438535880598;10371.740706482398;379.99810000950373;384.0762965069014;385.6336480343685;394.44777311763187;403.1614242375851;5464.371597266286;5549.112142057252;5560.7219639017885;8860.246879015227;9118.22495087925;459417;468525;471152;482227;486297;66803;71133;72055.63972180105;72432.27567724361;73723;1064.6752740414092;1068.2949253492814;1094.7536804218987;1126.132877684195;1129.7853407852647;14417.13497190172;14448.422063117358;14528.128312301296;14573.344199511259;14757;32917.50623740598;32987.835060824546;34318;34611;35064;43589.34615980699;43802.34296485619;45332;45492.77253613843;45551.772241138584;8674.52533069367;8733.214010739064;8860.512671802855;8889.777755556162;8986.415882967585;15496.535103946899;15519.45681901128;15533.223338833239;15782.447614333443;15901.443449479213;10162.695119146438;12498.187617804813;13065.216087034809;13237.669058273621;13315.600531984055;10709.678709638723;11818.349990750592;12072.215306005082;12562.309073001074;12705;12662.303573303188;12715.173513721578;12805.935970320088;13073.280969546766;13237.40431680596;8302.169783021649;8596.957015214884;8629.09394513592;8633.525156116473;8855.690050848189;9225.49259790718;11887.28676279426;12394.132410731523;12832.486700532249;13158.60524184276 04:44:08 INFO - 2015-12-04 04:44:08,592 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1477.3425825507654;1635.501172142497;1669.2988944643248;1698.2442812948236;1709.4615196213188;5976.073708575167;6153.56925015248;6653.800385988422;6851.486138539611;6884.070650462192;6753.189617245925;6956.8956465653055;6999.950007498865;7013.614251216181;7023.122109736283;2008.7187793708893;2053.979460205394;2054.8869812160324;2055.486128467883;2058.3001779395004;2079.8752074875556;2117.9894100529477;2121.9469513262216;2142.72144621199;2157.9352619421365;1993.4816947593658;2013.2550956146247;2014.677651575748;2022.3932820153968;2022.4135000849735;2060.361288000717;2075.8997731202485;2078.262216912989;2078.449210959097;2081.1467298407733;2026.787187345337;2042;2045.539753555453;2061.8247448966854;2083.125087463269;6768.729250829961;6843.315668433117;6869.793906182823;6878.105846239957;6891.827704307382;3986.66113380363;4038.1318016626565;4052.5947405259535;4056.3509838426007;4063.878083657495;2288.794008539223;2344.718633763959;2633.8156329056974;2681.637978872847;2694.2725464124774;804.0913767442752;820.4379999700225;833.8874251975966;834.4742812028444;850.196564246787;9401.247900168039;9403.717888463358;9413.905860941371;9463.148316651534;9479.952600236955;3899.8830035098426;3923.489946306962;3973.8807835764974;3998.4801975742967;4024.436578878959;8062.959685201537;8096.190380961974;8182.059063207688;8184.140665230184;8213.95893020543;4109.301418758759;4117.547069822317;4134.503859536815;4147.854825081107;4153.8338466461;3678.9632103679155;3703.703703703751;3708.4622729704042;3712;3717.1450566369344;3427.674370934757;3446.172918499542;3463.8614455422003;3486.2156014896445;3491.755577109578;1103.1230172013268;1117.6647005898199;1119.1662211652208;1122.3266040375709;1127.21095233337;1161.7618388230392;1181.0433548825479;1182.8166634171716;1193.4689063366893;1197.6407077876777;6668.233153187445;6680.432163266177;6717.865642687118;6746.055552222692;6748.595084294958;428.2676622974686;430.169772339388;434.4178800407469;437.3832895617228;437.87958311464604;5215.530602245816;5217.295665085241;5254.448282930313;5261.710605916712;5265.183896496049;7441.181470038291;7510.1363343215135;8220;8406.957965210257;8411.411201215857;8200.466969646954;8219.95890020546;8238.176182381714;8245.13426090264;8262.504249745034;6253.593516421418;6350.714217860207;6444.806655800334;6448.032795080681;6473.352664733489;6500.479961602966;6511.9348806511325;6535.248446428722;6539.378759017885;6555.115059466911;7482.663280152297;7556.65995030214;7699.422543309162;7718.768436946901;7742.458027937991;7749.496282741604;7805.141434442094;7983.361331093382;8012.919870801217;8076.111627720828;6066.332703402534;6086.452219300284;6105.786297479567;6124.724387402666;6144.41628045335;6466.256380516113;6606.570572912745;6606.933930660824;6607.438367738604;6617.0405291233465;6381.8085457436355;6462.192225971754;6506.121673574007;6555.344465553407;6588.967055164693;6279.905801412891;6300.716467759054;6335.873282534231;6408;6441.71012304438;6221;6293.716782744879;6316.842078948063;6317.873642527215;6368.681565921593;5841.620294680833;5885.764569417175;5893.970530147321;5912.290525137011;5930.52555795544;6069.726862291296;6108.541859360477;6109.84725381869;6143.6928153593035;6185.257769067741 04:44:08 INFO - 2015-12-04 04:44:08,592 DEBUG : BROWSER_OUTPUT: |4;prototype.html;278.12113720642765;286.8293365447558;287.14860438798956;287.3520211922115;288.71273083282136;5385.515303622673;5593.580481463891;5654.519365853897;5676.574256930726;5685.943140568593;5541.833744987647;5596.4123767004485;5614.214010038598;5619.157126431038;5631.831045068655;4264.104538047014;4265.083007153461;4265.552117027714;4270.359446083081;4274.29474136767;4265.552117027714;4266.445362102922;4273.4444522212225;4276.657867370603;4281.229378711831;4122.2579935611575;4222.59885310895;4231.090315582164;4231.576842315759;4233.343831706091;4204.264253755596;4210;4213.241616509043;4230.111676547928;4235.385869048971;3613.8012409317475;3614.945775813365;3615.692666123383;3615.7649752766247;3618.475321078429;5447.891042179174;5458.563314934796;5458.590605704588;5462.6995515246645;5478.315210598676;4869.4156701195725;4874.390701162355;4878.487758785312;4880.731559764212;4882.633802464829;5674.3190817101795;5752.712364381764;5882.705864706748;5908.763649454059;5915.733791979371;3882.7476214045996;3918.666913312372;3923.941140882889;3924.391719283487;3930.980345098285;6106;6169.2288463942;6175.629462232236;6234.127222188898;6241.65670888101;3921.039345360348;3988.3219852625125;3988.4615576897327;3992.740471869319;4003.719739618257;4057.776822274744;4072.1041370898356;4096.549379568245;4098.774567398762;4102.50769907613;4752.572268495852;4771.73755443454;4788.664793464493;4793.880152996203;4808.422989241313;5900.380460051719;5905.438983296666;5906.527477801766;5908.970455147783;5926.525877929756;1424.038773827683;1432.44134787433;1445.0390490324028;1445.3929349673163;1445.7180849734411;937.8546325319586;938.2728385501291;940.7412961435523;955.8279509688323;963.4026903319987;5122.462141475092;5132.871678208;5134.4352121267375;5136.845894623168;5163.251328557338;6136.294326152461;6137.60105593135;6171.722272497748;6190.50475961931;6197;5115.667481613683;5132.255822905658;5137.434882163034;5137.563307118862;5139.7687104080405;3248;3324.80051196929;3336.299377130781;3336.6830151135605;3342.6824451677053;5754.338251101093;5755.568332375088;5826.533877289807;5826.563007774434;5827.650340979555;6379.74481020754;6387.361263873576;6397.52018598607;6406.039094135824;6422.068800023971;5686.2039314496005;5797.246357973437;5823.4467725566;5831.037878750044;5832.912506312408;6027.457528822427;6150.1082343059115;6216.844578885564;6225.533085018551;6264.091706702411;6058.363871793398;6060.393960603904;6071.605345652519;6074.848128796815;6094.54290928191;5824.970875145597;5831.533477321889;5833.504152146946;5835.620684655484;5840.795572154954;3993.3610622300293;4008.579099194543;4081.4898137732785;4089.7955102245364;4092.8158232878995;6201.286852012076;6222.81331560054;6235.875282494234;6238.407351301619;6245.406686364788;5941.465268125889;5960.165576819162;5963.0459126539545;5979.940200597938;5987.730552125252;5871.530277577869;5932.584719069624;5940.524758019262;5988.071848863433;6005;5790.623609465371;5797.449242321973;5841.8539536510225;5849.327327357239;5851.678157701197;5994.340622531605;5999.5800293979;6007.158997740407;6024.246969128859;6032;5740.569457290637;5818.970905145447;5867.647941123546;5874.794382196603;5875.236219291465 04:44:08 INFO - 2015-12-04 04:44:08,593 DEBUG : BROWSER_OUTPUT: |5;yui.html;715.9964200178998;742.0029125347968;767.2480968650722;781.827997840475;815.6533473273864;11966.521339146435;12450.875491245084;12454.128211025232;12558.05814563908;12568.622941311753;11680.357580333079;11834.585789497369;11843.230190037642;11877.643670689893;11896.10779191562;784.3764207455073;795.7016118955391;802.6869520886859;803.7186984555389;806.7095845495617;805.5649949027518;806.105223202245;811.0267678785451;811.1645005644195;812.1837553258966;827.896512935883;831.5426515416527;835.6490274084899;837.8282452097305;840.0213750980131;831.8045259364045;832.950022998616;833.6790335720731;834.1075049696797;834.837206744685;613.6624856329001;617.3147805935408;618.935011823761;619.7025427794683;621.2172662445306;11756.764864702744;12500.874991250063;12508.437120329607;12557.811632825515;12578.937105314506;10545;10756.73108172294;10912.836307455394;10937.890621093768;11205.495752691148;8844.778880527974;9151.405158664666;9155.862662060075;9272.072792720674;9557.90442095577;3138.1213260287154;3169.793963392372;3182.3953448844877;3237.2392487765355;3246.902592922216;41237.79381103105;41518;41887;41924.58075419237;41998.74003779922;8656.39405241627;8659.48043117415;8730.257928076058;8824.735257942144;8839.116088391109;15917.681646367007;16084.839151608568;16150;16154;16195.514134575982;6160.10678451631;6226.159468471789;6255.74977000924;6398.328175541501;6514.543981921315;3302.455094909361;3338.7829791063505;3386.2211691311136;3410.556627638391;3419.897403077912;2610;2620.4235068284947;2639.1158961747647;2640.1287575100173;2658.1493921944793;495.2422793126522;498.0288437546798;499.88752530680307;504.70222568684653;505.32539060354105;457.5675986193016;460.2038473440966;500.3345550417935;501.0930216308493;558.6620094842643;7010.193827709777;7179.712811487587;7221;7233.638318084075;7238.782836514913;439.70759444968735;479.4558176469732;576.4120596991129;610.8045425463898;635.4598591197538;3779.4897688812207;3841;3892.630200130983;3928.371460566296;3961.7622942623534;47668.28497572539;47719.522804772205;48003.5199647999;50961.49038509642;51792.22311665328;45150.77424612856;45381.54618453839;45445.318320225226;45649;45754.54245457569;39740.60259397427;40802.95985200728;40900.181996359905;41274.79362603168;41280.967975800246;7848.175941526058;8004.479708818908;8045;8149.103598604031;8258.050324212552;30377.544336834522;30945.690543094282;31063.223419413793;32164.678353217103;32742.67257327396;40071;40539;40693.79653101716;41283;41338.58661413348;9829.950850245703;9936.105750482491;10162.847557286499;10191.796164076824;10480.68557943263;10978.670639880816;10995.230333876552;11058.336499810037;11662.825057624312;12007.39963001829;10288;10984.121270298518;11063.72340691489;11167.553297868319;11424.714382140513;10296.536655850356;10651.733706657085;10999.450027498753;11399;11404.429778510876;8972.28221742246;9106.863397048917;9176.632934682804;9459.858102128612;10064.748381290527;8803.603837827184;8834.867476987978;8921.375503714678;9008.41445306053;9054.818903622023;8716.215540601377;8771;8882.378233523592;8903.643854245758;8938.284937204879 04:44:08 INFO - 2015-12-04 04:44:08,593 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,331 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233048585__endTimestamp 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4709.68 Median:4837.25 stddev:508.66 (10.5%) stddev-sans-first:484.05 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: Values: 2656.7 2711.2 2734.7 2736.1 2750.3 4548.2 4756.8 4779.9 4797.9 4801.0 4595.2 4628.2 4647.6 4700.8 4738.1 4305.6 4337.0 4352.5 4442.3 4542.7 4452.3 4468.4 4490.9 4537.5 4565.0 4143.5 4266.0 4350.6 4461.3 4486.2 4393.1 4414.2 4426.5 4432.7 4455.1 4119.7 4409.7 4411.4 4421.0 4465.4 4550.4 4608.4 4667.5 4678.3 4683.8 5150.3 5155.5 5175.7 5177.9 5231.9 4781.2 4969.0 5177.9 5199.8 5209.8 4735.4 4788.4 4823.3 4837.3 4868.9 5305.8 5331.3 5333.9 5340.5 5376.9 4853.4 4951.1 4958.3 5099.8 5111.3 5147.6 5151.0 5166.1 5166.7 5194.9 5114.0 5115.2 5121.8 5137.3 5176.5 4786.7 4868.7 4877.0 4896.9 5106.4 4131.5 4150.5 4153.5 4223.6 4231.0 3704.8 3705.6 3710.8 3719.5 3751.6 4177.3 4365.0 4372.4 4381.1 4424.5 5019.1 5040.1 5128.6 5130.6 5190.7 4368.1 4373.7 4405.7 4413.1 4438.2 4352.8 4467.2 4562.6 4565.0 4575.8 4744.4 4761.8 4772.1 4807.4 4860.5 5133.8 5213.2 5217.3 5220.9 5269.8 4609.4 4822.6 4898.4 4899.1 4908.9 4882.1 4953.7 5027.0 5029.8 5075.6 5152.6 5213.6 5216.4 5258.0 5263.9 4851.5 4977.6 5034.6 5072.6 5076.4 4890.0 4950.0 4966.1 4974.3 5013.9 4872.1 4879.0 4888.9 4899.4 4962.1 4829.3 4869.1 4935.7 5050.1 5099.4 4879.2 4934.1 4939.9 4949.7 4963.4 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,594 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50461.98 Median:37509.69 stddev:103870.03 (276.9%) stddev-sans-first:104093.82 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: Values: 554.9 562.3 570.6 576.8 577.0 36496.1 37134.8 37262.4 37428.6 37501.0 40157.6 40663.0 40765.8 40814.6 41081.2 7861.1 8055.7 8056.6 8079.2 8101.4 7867.3 7966.2 7980.0 8005.2 8015.4 7877.6 7900.8 7936.2 7948.7 7952.0 7904.6 7992.4 7998.4 8001.5 8018.3 7816.6 7871.0 7910.2 7943.3 7951.1 36747.8 37323.3 37497.0 37518.4 37550.6 2742.5 2744.6 2834.6 2908.7 3338.3 28511.0 28669.4 28791.3 28858.7 29086.0 3375.3 3387.6 3452.4 3456.1 3541.5 218279.0 219176.0 219492.0 219636.0 220530.0 51810.0 52824.7 55947.0 56711.0 61203.7 57236.4 58504.4 58652.4 58654.7 58748.7 12106.5 12184.7 12245.2 12267.6 12312.0 9058.8 9121.7 9160.0 9163.6 9174.5 18947.8 19193.3 19214.2 19314.7 19418.2 7652.8 7774.2 7825.2 7829.8 7867.4 818.7 915.7 925.7 1007.8 1022.2 26004.5 26031.0 26239.2 26289.9 26467.3 901.6 985.2 991.4 1029.0 1062.3 13717.5 13775.7 13883.2 14019.4 14069.9 568780.0 577643.0 582502.0 584258.0 585179.0 48328.0 48843.5 48876.3 48941.5 49187.0 1207.5 1229.4 1230.2 1230.4 1233.3 26726.0 26807.6 27292.5 27389.6 29512.9 43186.4 43743.3 43792.0 43792.8 43803.0 254561.0 257210.0 257955.0 258145.0 259654.0 39040.2 41942.2 42271.0 42410.2 42832.8 39853.2 39959.4 40449.6 41216.0 41235.4 34016.1 34604.8 34643.8 34819.8 35097.3 34707.8 34846.8 35110.0 36329.8 38927.2 34686.5 34933.5 35214.5 35289.6 35399.1 29723.4 31197.5 31822.4 31854.5 31990.2 24137.9 24188.2 24361.3 24439.3 24475.6 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25442.46 Median:398.80 stddev:77482.51 (19428.7%) stddev-sans-first:77676.89 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: Values: 310.0 322.9 324.2 324.9 327.7 15834.7 15869.7 16200.4 16322.3 16538.7 13993.2 14100.9 14131.9 14156.3 14192.2 4563.5 4567.9 4651.8 4667.5 4669.1 4590.1 4626.2 4626.7 4646.8 4675.0 3303.2 4644.8 4660.2 5406.4 5729.8 5617.8 5636.6 5703.7 5711.1 5720.1 4953.1 5037.8 5043.2 5065.6 5066.3 11054.3 11266.3 11292.8 11434.6 11436.7 1756.7 1815.7 1894.6 1907.1 1912.2 8979.4 9414.3 9419.4 11887.0 12698.7 414.8 823.0 1763.6 1777.7 1811.8 54048.0 55854.0 56370.0 56652.4 56705.4 9571.4 9693.7 9721.5 9753.7 9768.6 12215.1 12216.5 12228.3 12231.8 12264.1 6318.9 6423.2 6431.4 6433.9 6434.2 5754.0 5895.5 6103.8 6104.2 6160.2 4105.6 4127.4 4140.6 4174.7 4196.1 1703.4 1722.8 1727.0 1777.2 1791.4 372.4 377.2 386.8 917.4 997.8 9968.6 10080.1 10173.6 10208.4 10371.7 380.0 384.1 385.6 394.4 403.2 5464.4 5549.1 5560.7 8860.2 9118.2 459417.0 468525.0 471152.0 482227.0 486297.0 66803.0 71133.0 72055.6 72432.3 73723.0 1064.7 1068.3 1094.8 1126.1 1129.8 14417.1 14448.4 14528.1 14573.3 14757.0 32917.5 32987.8 34318.0 34611.0 35064.0 43589.3 43802.3 45332.0 45492.8 45551.8 8674.5 8733.2 8860.5 8889.8 8986.4 15496.5 15519.5 15533.2 15782.4 15901.4 10162.7 12498.2 13065.2 13237.7 13315.6 10709.7 11818.3 12072.2 12562.3 12705.0 12662.3 12715.2 12805.9 13073.3 13237.4 8302.2 8597.0 8629.1 8633.5 8855.7 9225.5 11887.3 12394.1 12832.5 13158.6 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4882.22 Median:6109.19 stddev:2523.80 (41.3%) stddev-sans-first:2517.91 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: Values: 1477.3 1635.5 1669.3 1698.2 1709.5 5976.1 6153.6 6653.8 6851.5 6884.1 6753.2 6956.9 7000.0 7013.6 7023.1 2008.7 2054.0 2054.9 2055.5 2058.3 2079.9 2118.0 2121.9 2142.7 2157.9 1993.5 2013.3 2014.7 2022.4 2022.4 2060.4 2075.9 2078.3 2078.4 2081.1 2026.8 2042.0 2045.5 2061.8 2083.1 6768.7 6843.3 6869.8 6878.1 6891.8 3986.7 4038.1 4052.6 4056.4 4063.9 2288.8 2344.7 2633.8 2681.6 2694.3 804.1 820.4 833.9 834.5 850.2 9401.2 9403.7 9413.9 9463.1 9480.0 3899.9 3923.5 3973.9 3998.5 4024.4 8063.0 8096.2 8182.1 8184.1 8214.0 4109.3 4117.5 4134.5 4147.9 4153.8 3679.0 3703.7 3708.5 3712.0 3717.1 3427.7 3446.2 3463.9 3486.2 3491.8 1103.1 1117.7 1119.2 1122.3 1127.2 1161.8 1181.0 1182.8 1193.5 1197.6 6668.2 6680.4 6717.9 6746.1 6748.6 428.3 430.2 434.4 437.4 437.9 5215.5 5217.3 5254.4 5261.7 5265.2 7441.2 7510.1 8220.0 8407.0 8411.4 8200.5 8220.0 8238.2 8245.1 8262.5 6253.6 6350.7 6444.8 6448.0 6473.4 6500.5 6511.9 6535.2 6539.4 6555.1 7482.7 7556.7 7699.4 7718.8 7742.5 7749.5 7805.1 7983.4 8012.9 8076.1 6066.3 6086.5 6105.8 6124.7 6144.4 6466.3 6606.6 6606.9 6607.4 6617.0 6381.8 6462.2 6506.1 6555.3 6589.0 6279.9 6300.7 6335.9 6408.0 6441.7 6221.0 6293.7 6316.8 6317.9 6368.7 5841.6 5885.8 5894.0 5912.3 5930.5 6069.7 6108.5 6109.8 6143.7 6185.3 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,596 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4865.97 Median:5625.49 stddev:1487.79 (26.4%) stddev-sans-first:1451.57 04:44:08 INFO - 2015-12-04 04:44:08,598 DEBUG : BROWSER_OUTPUT: Values: 278.1 286.8 287.1 287.4 288.7 5385.5 5593.6 5654.5 5676.6 5685.9 5541.8 5596.4 5614.2 5619.2 5631.8 4264.1 4265.1 4265.6 4270.4 4274.3 4265.6 4266.4 4273.4 4276.7 4281.2 4122.3 4222.6 4231.1 4231.6 4233.3 4204.3 4210.0 4213.2 4230.1 4235.4 3613.8 3614.9 3615.7 3615.8 3618.5 5447.9 5458.6 5458.6 5462.7 5478.3 4869.4 4874.4 4878.5 4880.7 4882.6 5674.3 5752.7 5882.7 5908.8 5915.7 3882.7 3918.7 3923.9 3924.4 3931.0 6106.0 6169.2 6175.6 6234.1 6241.7 3921.0 3988.3 3988.5 3992.7 4003.7 4057.8 4072.1 4096.5 4098.8 4102.5 4752.6 4771.7 4788.7 4793.9 4808.4 5900.4 5905.4 5906.5 5909.0 5926.5 1424.0 1432.4 1445.0 1445.4 1445.7 937.9 938.3 940.7 955.8 963.4 5122.5 5132.9 5134.4 5136.8 5163.3 6136.3 6137.6 6171.7 6190.5 6197.0 5115.7 5132.3 5137.4 5137.6 5139.8 3248.0 3324.8 3336.3 3336.7 3342.7 5754.3 5755.6 5826.5 5826.6 5827.7 6379.7 6387.4 6397.5 6406.0 6422.1 5686.2 5797.2 5823.4 5831.0 5832.9 6027.5 6150.1 6216.8 6225.5 6264.1 6058.4 6060.4 6071.6 6074.8 6094.5 5825.0 5831.5 5833.5 5835.6 5840.8 3993.4 4008.6 4081.5 4089.8 4092.8 6201.3 6222.8 6235.9 6238.4 6245.4 5941.5 5960.2 5963.0 5979.9 5987.7 5871.5 5932.6 5940.5 5988.1 6005.0 5790.6 5797.4 5841.9 5849.3 5851.7 5994.3 5999.6 6007.2 6024.2 6032.0 5740.6 5819.0 5867.6 5874.8 5875.2 04:44:08 INFO - 2015-12-04 04:44:08,598 DEBUG : BROWSER_OUTPUT: 04:44:08 INFO - 2015-12-04 04:44:08,598 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12286.98 Median:23107.37 stddev:14009.79 (60.6%) stddev-sans-first:14022.15 04:44:08 INFO - 2015-12-04 04:44:08,598 DEBUG : BROWSER_OUTPUT: Values: 716.0 742.0 767.2 781.8 815.7 11966.5 12450.9 12454.1 12558.1 12568.6 11680.4 11834.6 11843.2 11877.6 11896.1 784.4 795.7 802.7 803.7 806.7 805.6 806.1 811.0 811.2 812.2 827.9 831.5 835.6 837.8 840.0 831.8 833.0 833.7 834.1 834.8 613.7 617.3 618.9 619.7 621.2 11756.8 12500.9 12508.4 12557.8 12578.9 10545.0 10756.7 10912.8 10937.9 11205.5 8844.8 9151.4 9155.9 9272.1 9557.9 3138.1 3169.8 3182.4 3237.2 3246.9 41237.8 41518.0 41887.0 41924.6 41998.7 8656.4 8659.5 8730.3 8824.7 8839.1 15917.7 16084.8 16150.0 16154.0 16195.5 6160.1 6226.2 6255.7 6398.3 6514.5 3302.5 3338.8 3386.2 3410.6 3419.9 2610.0 2620.4 2639.1 2640.1 2658.1 495.2 498.0 499.9 504.7 505.3 457.6 460.2 500.3 501.1 558.7 7010.2 7179.7 7221.0 7233.6 7238.8 439.7 479.5 576.4 610.8 635.5 3779.5 3841.0 3892.6 3928.4 3961.8 47668.3 47719.5 48003.5 50961.5 51792.2 45150.8 45381.5 45445.3 45649.0 45754.5 39740.6 40803.0 40900.2 41274.8 41281.0 7848.2 8004.5 8045.0 8149.1 8258.1 30377.5 30945.7 31063.2 32164.7 32742.7 40071.0 40539.0 40693.8 41283.0 41338.6 9830.0 9936.1 10162.8 10191.8 10480.7 10978.7 10995.2 11058.3 11662.8 12007.4 10288.0 10984.1 11063.7 11167.6 11424.7 10296.5 10651.7 10999.5 11399.0 11404.4 8972.3 9106.9 9176.6 9459.9 10064.7 8803.6 8834.9 8921.4 9008.4 9054.8 8716.2 8771.0 8882.4 8903.6 8938.3 04:44:08 INFO - 2015-12-04 04:44:08,598 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:44:08 INFO - 2015-12-04 04:44:08,598 DEBUG : BROWSER_OUTPUT: 04:44:09 INFO - 2015-12-04 04:44:09,317 INFO : Browser exited with error code: 0 04:44:09 INFO - 2015-12-04 04:44:09,338 INFO : Completed test dromaeo_css (00:18:35) 04:44:09 INFO - 2015-12-04 04:44:09,339 INFO : Starting test kraken 04:44:09 INFO - 2015-12-04 04:44:09,339 DEBUG : operating with platform_type : linux_ 04:44:09 INFO - 2015-12-04 04:44:09,339 INFO : Initialising browser for kraken test... 04:44:09 INFO - 2015-12-04 04:44:09,345 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKP_ul8/profile http://localhost:42487/getInfo.html 04:44:14 INFO - 2015-12-04 04:44:14,127 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:44:14 INFO - 2015-12-04 04:44:14,127 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:44:14 INFO - 2015-12-04 04:44:14,127 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:44:14 INFO - 2015-12-04 04:44:14,127 DEBUG : BROWSER_OUTPUT: __metrics 04:44:14 INFO - 2015-12-04 04:44:14,243 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:44:15 INFO - 2015-12-04 04:44:15,141 INFO : Browser initialized. 04:44:15 INFO - 2015-12-04 04:44:15,142 INFO : Running cycle 1/1 for kraken test... 04:44:15 INFO - 2015-12-04 04:44:15,142 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKP_ul8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:44:27 INFO - 2015-12-04 04:44:27,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 143052800 04:44:27 INFO - 2015-12-04 04:44:27,303 DEBUG : BROWSER_OUTPUT: 04:44:29 INFO - 2015-12-04 04:44:29,864 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-beat-detection) 04:44:30 INFO - 2015-12-04 04:44:30,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 142733312 04:44:30 INFO - 2015-12-04 04:44:30,478 DEBUG : BROWSER_OUTPUT: 04:44:33 INFO - 2015-12-04 04:44:33,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-dft) 04:44:33 INFO - 2015-12-04 04:44:33,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 143474688 04:44:33 INFO - 2015-12-04 04:44:33,842 DEBUG : BROWSER_OUTPUT: 04:44:36 INFO - 2015-12-04 04:44:36,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-fft) 04:44:37 INFO - 2015-12-04 04:44:37,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 139173888 04:44:37 INFO - 2015-12-04 04:44:37,324 DEBUG : BROWSER_OUTPUT: 04:44:39 INFO - 2015-12-04 04:44:39,418 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42487/tests/kraken/driver.html?testName=audio-oscillator) 04:44:40 INFO - 2015-12-04 04:44:40,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 138915840 04:44:40 INFO - 2015-12-04 04:44:40,045 DEBUG : BROWSER_OUTPUT: 04:44:42 INFO - 2015-12-04 04:44:42,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42487/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:44:42 INFO - 2015-12-04 04:44:42,885 DEBUG : BROWSER_OUTPUT: RSS: Main: 140963840 04:44:42 INFO - 2015-12-04 04:44:42,886 DEBUG : BROWSER_OUTPUT: 04:44:45 INFO - 2015-12-04 04:44:45,910 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42487/tests/kraken/driver.html?testName=imaging-darkroom) 04:44:46 INFO - 2015-12-04 04:44:46,511 DEBUG : BROWSER_OUTPUT: RSS: Main: 138985472 04:44:46 INFO - 2015-12-04 04:44:46,512 DEBUG : BROWSER_OUTPUT: 04:44:50 INFO - 2015-12-04 04:44:50,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42487/tests/kraken/driver.html?testName=imaging-desaturate) 04:44:50 INFO - 2015-12-04 04:44:50,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 137818112 04:44:50 INFO - 2015-12-04 04:44:50,638 DEBUG : BROWSER_OUTPUT: 04:44:53 INFO - 2015-12-04 04:44:53,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42487/tests/kraken/driver.html?testName=json-parse-financial) 04:44:54 INFO - 2015-12-04 04:44:54,097 DEBUG : BROWSER_OUTPUT: RSS: Main: 137519104 04:44:54 INFO - 2015-12-04 04:44:54,097 DEBUG : BROWSER_OUTPUT: 04:44:55 INFO - 2015-12-04 04:44:55,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42487/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:44:56 INFO - 2015-12-04 04:44:56,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 139997184 04:44:56 INFO - 2015-12-04 04:44:56,437 DEBUG : BROWSER_OUTPUT: 04:44:58 INFO - 2015-12-04 04:44:58,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:44:58 INFO - 2015-12-04 04:44:58,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 141230080 04:44:58 INFO - 2015-12-04 04:44:58,934 DEBUG : BROWSER_OUTPUT: 04:45:01 INFO - 2015-12-04 04:45:01,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:45:01 INFO - 2015-12-04 04:45:01,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 140673024 04:45:01 INFO - 2015-12-04 04:45:01,694 DEBUG : BROWSER_OUTPUT: 04:45:04 INFO - 2015-12-04 04:45:04,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:45:04 INFO - 2015-12-04 04:45:04,832 DEBUG : BROWSER_OUTPUT: RSS: Main: 141651968 04:45:04 INFO - 2015-12-04 04:45:04,832 DEBUG : BROWSER_OUTPUT: 04:45:07 INFO - 2015-12-04 04:45:07,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:45:08 INFO - 2015-12-04 04:45:08,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 140333056 04:45:08 INFO - 2015-12-04 04:45:08,059 DEBUG : BROWSER_OUTPUT: 04:45:09 INFO - 2015-12-04 04:45:09,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42487/tests/kraken/driver.html?testName=ai-astar) 04:45:10 INFO - 2015-12-04 04:45:10,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 140787712 04:45:10 INFO - 2015-12-04 04:45:10,091 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,091 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:45:10 INFO - 2015-12-04 04:45:10,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:45:10 INFO - 2015-12-04 04:45:10,091 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;106;112;113;113;124;111;111;111;113 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;130;152;175;143;167;152;134;176;130 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;166;166;165;164;168;165;163;163;164 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;72;72;74;72;137;74;74;73 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;130;95;96;95;131;95;95;133 04:45:10 INFO - 2015-12-04 04:45:10,092 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;110;110;111;111;111;110;111;110 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;148;149;147;149;148;147;148 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;97;96;96;96;96;96;96;97 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;72;75;71;70;72;73;72;71;70 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;72;70;68;68;67 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;85;85;84;85;93;84;85;85;85 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;131;129;122;121;129;130;121;124;126;140 04:45:10 INFO - 2015-12-04 04:45:10,093 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;147;146;144;155;154;149;146;148;140 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;72;70;69;69;70;72;69;68;71 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,790 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233110086__endTimestamp 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,094 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:4.52 (4.0%) stddev-sans-first:4.77 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: Values: 114.0 106.0 112.0 113.0 113.0 124.0 111.0 111.0 111.0 113.0 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.00 Median:152.00 stddev:17.30 (11.4%) stddev-sans-first:18.35 04:45:10 INFO - 2015-12-04 04:45:10,095 DEBUG : BROWSER_OUTPUT: Values: 151.0 130.0 152.0 175.0 143.0 167.0 152.0 134.0 176.0 130.0 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:1.78 (1.1%) stddev-sans-first:1.62 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: Values: 162.0 166.0 166.0 165.0 164.0 168.0 165.0 163.0 163.0 164.0 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:73.00 stddev:20.26 (27.7%) stddev-sans-first:21.35 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 72.0 74.0 72.0 137.0 74.0 74.0 73.0 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:95.00 stddev:17.57 (18.5%) stddev-sans-first:18.19 04:45:10 INFO - 2015-12-04 04:45:10,096 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 130.0 95.0 96.0 95.0 131.0 95.0 95.0 133.0 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:111.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 110.0 110.0 111.0 111.0 111.0 110.0 111.0 110.0 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 148.0 149.0 147.0 149.0 148.0 147.0 148.0 04:45:10 INFO - 2015-12-04 04:45:10,097 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,098 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 04:45:10 INFO - 2015-12-04 04:45:10,098 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 97.0 04:45:10 INFO - 2015-12-04 04:45:10,098 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,098 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:72.00 stddev:1.48 (2.0%) stddev-sans-first:1.56 04:45:10 INFO - 2015-12-04 04:45:10,098 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 75.0 71.0 70.0 72.0 73.0 72.0 71.0 70.0 04:45:10 INFO - 2015-12-04 04:45:10,098 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 72.0 70.0 68.0 68.0 67.0 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.00 stddev:2.63 (3.1%) stddev-sans-first:2.78 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: Values: 85.0 85.0 85.0 84.0 85.0 93.0 84.0 85.0 85.0 85.0 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:129.00 stddev:5.85 (4.5%) stddev-sans-first:6.05 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: Values: 131.0 129.0 122.0 121.0 129.0 130.0 121.0 124.0 126.0 140.0 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,099 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:147.50 stddev:4.40 (3.0%) stddev-sans-first:4.66 04:45:10 INFO - 2015-12-04 04:45:10,100 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 144.0 155.0 154.0 149.0 146.0 148.0 140.0 04:45:10 INFO - 2015-12-04 04:45:10,100 DEBUG : BROWSER_OUTPUT: 04:45:10 INFO - 2015-12-04 04:45:10,100 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 04:45:10 INFO - 2015-12-04 04:45:10,100 DEBUG : BROWSER_OUTPUT: Values: 69.0 72.0 70.0 69.0 69.0 70.0 72.0 69.0 68.0 71.0 04:45:10 INFO - 2015-12-04 04:45:10,100 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:45:10 INFO - 2015-12-04 04:45:10,100 DEBUG : BROWSER_OUTPUT: 04:45:11 INFO - 2015-12-04 04:45:11,013 INFO : Browser exited with error code: 0 04:45:11 INFO - 2015-12-04 04:45:11,064 INFO : Completed test kraken (00:01:01) 04:45:11 INFO - 2015-12-04 04:45:11,064 INFO : Starting test v8_7 04:45:11 INFO - 2015-12-04 04:45:11,064 DEBUG : operating with platform_type : linux_ 04:45:11 INFO - 2015-12-04 04:45:11,064 INFO : Initialising browser for v8_7 test... 04:45:11 INFO - 2015-12-04 04:45:11,070 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17XUsV/profile http://localhost:42487/getInfo.html 04:45:16 INFO - 2015-12-04 04:45:16,027 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:45:16 INFO - 2015-12-04 04:45:16,027 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:45:16 INFO - 2015-12-04 04:45:16,027 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:45:16 INFO - 2015-12-04 04:45:16,027 DEBUG : BROWSER_OUTPUT: __metrics 04:45:16 INFO - 2015-12-04 04:45:16,164 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:45:17 INFO - 2015-12-04 04:45:17,113 INFO : Browser initialized. 04:45:17 INFO - 2015-12-04 04:45:17,114 INFO : Running cycle 1/1 for v8_7 test... 04:45:17 INFO - 2015-12-04 04:45:17,114 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp17XUsV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:45:29 INFO - 2015-12-04 04:45:29,254 DEBUG : BROWSER_OUTPUT: RSS: Main: 142823424 04:45:29 INFO - 2015-12-04 04:45:29,255 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42487/tests/v8_7/run.html (next: http://localhost:42487/tests/v8_7/run.html) 04:45:50 INFO - 2015-12-04 04:45:50,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 04:45:50 INFO - 2015-12-04 04:45:50,983 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,983 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:45:50 INFO - 2015-12-04 04:45:50,983 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:45:50 INFO - 2015-12-04 04:45:50,983 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:45:50 INFO - 2015-12-04 04:45:50,983 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:45:50 INFO - 2015-12-04 04:45:50,984 DEBUG : BROWSER_OUTPUT: |0;Richards;166.44474034620507 04:45:50 INFO - 2015-12-04 04:45:50,984 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.0481125092524 04:45:50 INFO - 2015-12-04 04:45:50,984 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 04:45:50 INFO - 2015-12-04 04:45:50,984 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 04:45:50 INFO - 2015-12-04 04:45:50,984 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1078.7486515641856 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: |5;Earley;712.2507122507122 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: |6;Boyer;12268.292682926829 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: |7;RegExp;25500 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: |8;Splay;580.3830528148578 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: __startTimestamp1449233150980__endTimestamp 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,985 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: Values: 166.4 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.05 Median:185.05 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: Values: 185.0 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: Values: 278.8 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: Values: 5202.1 04:45:50 INFO - 2015-12-04 04:45:50,986 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1078.75 Median:1078.75 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: Values: 1078.7 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:712.25 Median:712.25 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: Values: 712.3 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: Values: 12268.3 04:45:50 INFO - 2015-12-04 04:45:50,987 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25500.00 Median:25500.00 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: Values: 25500.0 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:580.38 Median:580.38 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: Values: 580.4 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:45:50 INFO - 2015-12-04 04:45:50,988 DEBUG : BROWSER_OUTPUT: Values: 4835.7 04:45:50 INFO - 2015-12-04 04:45:50,989 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:45:50 INFO - 2015-12-04 04:45:50,989 DEBUG : BROWSER_OUTPUT: 04:45:51 INFO - 2015-12-04 04:45:51,901 INFO : Browser exited with error code: 0 04:45:51 INFO - 2015-12-04 04:45:51,913 INFO : Completed test v8_7 (00:00:40) 04:45:51 INFO - 2015-12-04 04:45:51,989 INFO : Completed test suite (00:20:17) 04:45:51 INFO - 2015-12-04 04:45:51,989 DEBUG : Working with test: dromaeo_css 04:45:51 INFO - 2015-12-04 04:45:51,989 DEBUG : Generating results file: dromaeo_css 04:45:51 INFO - 2015-12-04 04:45:51,990 DEBUG : Working with test: kraken 04:45:51 INFO - 2015-12-04 04:45:51,990 DEBUG : Generating results file: kraken 04:45:51 INFO - 2015-12-04 04:45:51,991 INFO : javascript benchmark 04:45:51 INFO - 2015-12-04 04:45:51,991 DEBUG : Working with test: v8_7 04:45:51 INFO - 2015-12-04 04:45:51,991 DEBUG : Generating results file: v8_7 04:45:51 INFO - 2015-12-04 04:45:51,991 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:45:52 INFO - 2015-12-04 04:45:52,049 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:45:52 INFO - 2015-12-04 04:45:52,049 DEBUG : process_Request line: dromaeo_css 6280.63 graph.html#tests=[[72,94,43]] 04:45:52 INFO - 2015-12-04 04:45:52,049 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:45:52 INFO - 2015-12-04 04:45:52,086 DEBUG : process_Request line: kraken 1539.30 graph.html#tests=[[232,94,43]] 04:45:52 INFO - 2015-12-04 04:45:52,086 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:45:52 INFO - 2015-12-04 04:45:52,123 DEBUG : process_Request line: v8_7 21456.93 graph.html#tests=[[230,94,43]] 04:45:52 INFO - 2015-12-04 04:45:52,124 INFO : javascript benchmark 04:45:52 INFO - 2015-12-04 04:45:52,128 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2656.667916510436, 2711.2137480130764, 2734.7265273472653, 2736.1381164933046, 2750.2849259192612, 4548.204064288753, 4756.762161891905, 4779.9283010754825, 4797.880052998677, 4800.9519904800945, 4595.172868883599, 4628.1669299526075, 4647.604953578942, 4700.835470758524, 4738.123447162268, 4305.590968857953, 4337.049581798604, 4352.455943007124, 4442.289233722605, 4542.704724192933, 4452.332150177467, 4468.4414448193975, 4490.8877278067985, 4537.546245375469, 4565.018521017981, 4143.523494798092, 4265.9786701066605, 4350.630196433275, 4461.263891457906, 4486.192485352635, 4393.055493068973, 4414.183376075436, 4426.468823741139, 4432.711873728197, 4455.131249406367, 4119.691023173244, 4409.713368631029, 4411.360352748833, 4421.027373977719, 4465.419495465601, 4550.408446901914, 4608.423947006624, 4667.486576476585, 4678.251479763221, 4683.765811709435, 5150.27896094547, 5155.484451554852, 5175.741212939376, 5177.948220517822, 5231.921521177185, 4781.187198176319, 4968.975155124237, 5177.896442071137, 5199.766010529535, 5209.791608335662, 4735.431748190239, 4788.377510923558, 4823.324734537167, 4837.250226214942, 4868.926966095476, 5305.761240744176, 5331.333583302087, 5333.86665333362, 5340.546053585411, 5376.865578360494, 4853.4418541867435, 4951.084049450863, 4958.330625365602, 5099.796008159707, 5111.3355263815465, 5147.56245719118, 5151.0, 5166.070107380632, 5166.715830629276, 5194.92207616886, 5113.974430127825, 5115.18157094863, 5121.8463446096675, 5137.33214682089, 5176.456472070454, 4786.6888652238185, 4868.707877527359, 4877.024595080927, 4896.853094407174, 5106.361704786902, 4131.5455299916985, 4150.522689890641, 4153.522344930372, 4223.598758118035, 4230.957690423056, 3704.7962362070343, 3705.6294370562728, 3710.777353358807, 3719.460678201646, 3751.5685696144747, 4177.310743727251, 4365.039691267916, 4372.4315838941375, 4381.123775244963, 4424.491183513873, 5019.14674505335, 5040.092783299041, 5128.640995130305, 5130.563902068366, 5190.688558686491, 4368.060866913565, 4373.671974601918, 4405.691601587858, 4413.073254616503, 4438.245498265303, 4352.7823608819435, 4467.173572889026, 4562.58936695699, 4565.0, 4575.771211439414, 4744.430668319824, 4761.833335833229, 4772.117158325721, 4807.351007613927, 4860.465348811557, 5133.845984620468, 5213.191955246943, 5217.321748172713, 5220.895582088413, 5269.841904742864, 4609.354690343422, 4822.614190864652, 4898.436679781728, 4899.064012056805, 4908.9263661045825, 4882.072406242803, 4953.678010929278, 5026.974865125651, 5029.84910452687, 5075.568576671024, 5152.613553983391, 5213.646605084645, 5216.37403511581, 5258.0, 5263.868403289948, 4851.539103785135, 4977.552020318189, 5034.622403319839, 5072.5688316493515, 5076.36545431821, 4889.975550122226, 4949.950500494949, 4966.106100901872, 4974.328465657235, 5013.924791128063, 4872.098661747588, 4878.975605121952, 4888.877778055577, 4899.363082799213, 4962.106820772296, 4829.2997515359375, 4869.147899117569, 4935.728534930613, 5050.141475949024, 5099.36257967754, 4879.243717223836, 4934.087193869145, 4939.851804445872, 4949.678270912379, 4963.404391473046], "unit": "ms", "name": "dojo.html", "value": 4677.435266533715}, {"lowerIsBetter": false, "replicates": [554.8612846788303, 562.3308263166833, 570.5806232419171, 576.8327185116315, 576.9884602307953, 36496.08759781007, 37134.81432592837, 37262.44106338404, 37428.625713742855, 37501.0, 40157.59842401575, 40663.0, 40765.7961710191, 40814.59185408145, 41081.17837643245, 7861.135275119746, 8055.718049868256, 8056.597170141499, 8079.232472915063, 8101.4328996970235, 7867.291943725064, 7966.203379662045, 7980.0, 8005.239502247277, 8015.398845086613, 7877.645505952246, 7900.762977110696, 7936.206379362046, 7948.682052717884, 7952.045754509467, 7904.565248911307, 7992.3606111510935, 7998.400119990994, 8001.519908805491, 8018.318442932299, 7816.64825082867, 7871.0, 7910.169432209593, 7943.324817390471, 7951.085625153066, 36747.81626091879, 37323.25353492942, 37497.0, 37518.37371384004, 37550.62449375526, 2742.5474796658527, 2744.6294750208667, 2834.588984597222, 2908.7382135607686, 3338.3490219407227, 28511.0, 28669.42661146786, 28791.280217994718, 28858.711412885812, 29086.0, 3375.3249350130072, 3387.627360990289, 3452.3613131570487, 3456.084137703511, 3541.451075083366, 218279.0, 219175.9999999984, 219492.0, 219636.0, 220530.0, 51810.0, 52824.735876320374, 55947.0, 56711.0, 61203.69398152981, 57236.42763572394, 58504.4149558499, 58652.4134758647, 58654.706726466946, 58748.706256468446, 12106.455209515592, 12184.695382615506, 12245.204061736136, 12267.631971040882, 12312.0, 9058.773530661787, 9121.726348209564, 9159.95420022909, 9163.633454661738, 9174.541272936327, 18947.81052189488, 19193.32823351204, 19214.231430742613, 19314.71027934582, 19418.223271069, 7652.80867978305, 7774.183710710294, 7825.217478252243, 7829.804254893559, 7867.370610351159, 818.7298191596877, 915.697819719491, 925.6713866577403, 1007.8034783217203, 1022.1873610479538, 26004.479910401686, 26031.0, 26239.212823615322, 26289.868550657124, 26467.338316542242, 901.6438506789781, 985.2216748768536, 991.3556188477403, 1028.9864483483761, 1062.3360399750156, 13717.45130194801, 13775.726158641859, 13883.236421996686, 14019.439222430989, 14069.929650351683, 568780.0, 577643.0, 582502.0, 584258.0, 585179.0, 48328.0, 48843.511564884604, 48876.266855997186, 48941.51058489441, 49187.0, 1207.4687137659403, 1229.3853073463267, 1230.1511956749814, 1230.4340003598265, 1233.2662066070852, 26726.0, 26807.597886032116, 27292.454150916474, 27389.589156162274, 29512.852435737685, 43186.35220471758, 43743.34384984292, 43792.0, 43792.78103609462, 43803.0, 254561.0, 257210.0, 257955.0, 258145.0, 259654.0, 39040.2191956165, 41942.16115677731, 42271.0, 42410.15179696451, 42832.78583607062, 39853.20293594054, 39959.400608990305, 40449.59550404576, 41215.96960076022, 41235.38146927738, 34016.14959626029, 34604.82697586496, 34643.82678086694, 34819.82590087033, 35097.29805403929, 34707.82646086753, 34846.825765871006, 35110.0, 36329.81835090808, 38927.2214555713, 34686.47970280498, 34933.47599785955, 35214.47178292379, 35289.64710352864, 35399.115022123624, 29723.405531889675, 31197.532037019915, 31822.40887955639, 31854.522182166824, 31990.20024499313, 24137.879310603334, 24188.153414630404, 24361.26916192517, 24439.26682199537, 24475.632865506675], "unit": "ms", "name": "ext.html", "value": 17627.54419582535}, {"lowerIsBetter": false, "replicates": [310.01415498714096, 322.86762427404767, 324.2089302102869, 324.8992812228209, 327.692506897479, 15834.683306333895, 15869.682606347866, 16200.432984845518, 16322.265498052586, 16538.66922661546, 13993.230372329517, 14100.858991410083, 14131.858681413183, 14156.292185390716, 14192.219427931459, 4563.520830312819, 4567.88580285493, 4651.837185698501, 4667.509911459299, 4669.1362098011805, 4590.104929538741, 4626.236670949289, 4626.69926454781, 4646.790894409743, 4674.953250467503, 3303.207230264743, 4644.790984405709, 4660.1844677181525, 5406.378266499344, 5729.770809167629, 5617.831465056055, 5636.605437619368, 5703.686297253649, 5711.086226203808, 5720.11338242573, 4953.083679519301, 5037.848864534069, 5043.193089105725, 5065.6200784941275, 5066.316047333637, 11054.281471704313, 11266.267692599955, 11292.774144517063, 11434.599789007429, 11436.71408214793, 1756.7277072053853, 1815.7367181758702, 1894.5831916978243, 1907.094130288102, 1912.1968773115325, 8979.371443998923, 9414.29392795543, 9419.387739796892, 11887.0, 12698.73012698732, 414.81126087630355, 822.9958850205711, 1763.5943732941496, 1777.6977913754563, 1811.8056698742369, 54048.0, 55854.0, 56370.0, 56652.43347566513, 56705.43294567043, 9571.37786043905, 9693.660721874701, 9721.513924303756, 9753.732014838026, 9768.560414781352, 12215.083868709704, 12216.450259738333, 12228.266304021787, 12231.755364892651, 12264.141510094209, 6318.905216421757, 6423.229212494531, 6431.389018043372, 6433.8713225736155, 6434.227892652912, 5753.971230143822, 5895.528357731371, 6103.816885493442, 6104.17593624855, 6160.168377269011, 4105.630493255621, 4127.360259159835, 4140.627343539096, 4174.749515029047, 4196.076863090116, 1703.4378655043806, 1722.7846519185102, 1727.0, 1777.1558509707786, 1791.3551121596215, 372.3762697481707, 377.2436265288135, 386.7911327882912, 917.3761841947406, 997.8453339732208, 9968.601255949681, 10080.135384002904, 10173.643922462677, 10208.438535880598, 10371.740706482398, 379.99810000950373, 384.0762965069014, 385.6336480343685, 394.44777311763187, 403.1614242375851, 5464.371597266286, 5549.112142057252, 5560.7219639017885, 8860.246879015227, 9118.22495087925, 459417.0, 468525.0, 471152.0, 482227.0, 486297.0, 66803.0, 71133.0, 72055.63972180105, 72432.27567724361, 73723.0, 1064.6752740414092, 1068.2949253492814, 1094.7536804218987, 1126.132877684195, 1129.7853407852647, 14417.13497190172, 14448.422063117358, 14528.128312301296, 14573.344199511259, 14757.0, 32917.50623740598, 32987.835060824546, 34318.0, 34611.0, 35064.0, 43589.34615980699, 43802.34296485619, 45332.0, 45492.77253613843, 45551.772241138584, 8674.52533069367, 8733.214010739064, 8860.512671802855, 8889.777755556162, 8986.415882967585, 15496.535103946899, 15519.45681901128, 15533.223338833239, 15782.447614333443, 15901.443449479213, 10162.695119146438, 12498.187617804813, 13065.216087034809, 13237.669058273621, 13315.600531984055, 10709.678709638723, 11818.349990750592, 12072.215306005082, 12562.309073001074, 12705.0, 12662.303573303188, 12715.173513721578, 12805.935970320088, 13073.280969546766, 13237.40431680596, 8302.169783021649, 8596.957015214884, 8629.09394513592, 8633.525156116473, 8855.690050848189, 9225.49259790718, 11887.28676279426, 12394.132410731523, 12832.486700532249, 13158.60524184276], "unit": "ms", "name": "jquery.html", "value": 7562.356082264937}, {"lowerIsBetter": false, "replicates": [1477.3425825507654, 1635.501172142497, 1669.2988944643248, 1698.2442812948236, 1709.4615196213188, 5976.073708575167, 6153.56925015248, 6653.800385988422, 6851.486138539611, 6884.070650462192, 6753.189617245925, 6956.8956465653055, 6999.950007498865, 7013.614251216181, 7023.122109736283, 2008.7187793708893, 2053.979460205394, 2054.8869812160324, 2055.486128467883, 2058.3001779395004, 2079.8752074875556, 2117.9894100529477, 2121.9469513262216, 2142.72144621199, 2157.9352619421365, 1993.4816947593658, 2013.2550956146247, 2014.677651575748, 2022.3932820153968, 2022.4135000849735, 2060.361288000717, 2075.8997731202485, 2078.262216912989, 2078.449210959097, 2081.1467298407733, 2026.787187345337, 2042.0, 2045.539753555453, 2061.8247448966854, 2083.125087463269, 6768.729250829961, 6843.315668433117, 6869.793906182823, 6878.105846239957, 6891.827704307382, 3986.66113380363, 4038.1318016626565, 4052.5947405259535, 4056.3509838426007, 4063.878083657495, 2288.794008539223, 2344.718633763959, 2633.8156329056974, 2681.637978872847, 2694.2725464124774, 804.0913767442752, 820.4379999700225, 833.8874251975966, 834.4742812028444, 850.196564246787, 9401.247900168039, 9403.717888463358, 9413.905860941371, 9463.148316651534, 9479.952600236955, 3899.8830035098426, 3923.489946306962, 3973.8807835764974, 3998.4801975742967, 4024.436578878959, 8062.959685201537, 8096.190380961974, 8182.059063207688, 8184.140665230184, 8213.95893020543, 4109.301418758759, 4117.547069822317, 4134.503859536815, 4147.854825081107, 4153.8338466461, 3678.9632103679155, 3703.703703703751, 3708.4622729704042, 3712.0, 3717.1450566369344, 3427.674370934757, 3446.172918499542, 3463.8614455422003, 3486.2156014896445, 3491.755577109578, 1103.1230172013268, 1117.6647005898199, 1119.1662211652208, 1122.3266040375709, 1127.21095233337, 1161.7618388230392, 1181.0433548825479, 1182.8166634171716, 1193.4689063366893, 1197.6407077876777, 6668.233153187445, 6680.432163266177, 6717.865642687118, 6746.055552222692, 6748.595084294958, 428.2676622974686, 430.169772339388, 434.4178800407469, 437.3832895617228, 437.87958311464604, 5215.530602245816, 5217.295665085241, 5254.448282930313, 5261.710605916712, 5265.183896496049, 7441.181470038291, 7510.1363343215135, 8220.0, 8406.957965210257, 8411.411201215857, 8200.466969646954, 8219.95890020546, 8238.176182381714, 8245.13426090264, 8262.504249745034, 6253.593516421418, 6350.714217860207, 6444.806655800334, 6448.032795080681, 6473.352664733489, 6500.479961602966, 6511.9348806511325, 6535.248446428722, 6539.378759017885, 6555.115059466911, 7482.663280152297, 7556.65995030214, 7699.422543309162, 7718.768436946901, 7742.458027937991, 7749.496282741604, 7805.141434442094, 7983.361331093382, 8012.919870801217, 8076.111627720828, 6066.332703402534, 6086.452219300284, 6105.786297479567, 6124.724387402666, 6144.41628045335, 6466.256380516113, 6606.570572912745, 6606.933930660824, 6607.438367738604, 6617.0405291233465, 6381.8085457436355, 6462.192225971754, 6506.121673574007, 6555.344465553407, 6588.967055164693, 6279.905801412891, 6300.716467759054, 6335.873282534231, 6408.0, 6441.71012304438, 6221.0, 6293.716782744879, 6316.842078948063, 6317.873642527215, 6368.681565921593, 5841.620294680833, 5885.764569417175, 5893.970530147321, 5912.290525137011, 5930.52555795544, 6069.726862291296, 6108.541859360477, 6109.84725381869, 6143.6928153593035, 6185.257769067741], "unit": "ms", "name": "mootools.html", "value": 3959.933690151135}, {"lowerIsBetter": false, "replicates": [278.12113720642765, 286.8293365447558, 287.14860438798956, 287.3520211922115, 288.71273083282136, 5385.515303622673, 5593.580481463891, 5654.519365853897, 5676.574256930726, 5685.943140568593, 5541.833744987647, 5596.4123767004485, 5614.214010038598, 5619.157126431038, 5631.831045068655, 4264.104538047014, 4265.083007153461, 4265.552117027714, 4270.359446083081, 4274.29474136767, 4265.552117027714, 4266.445362102922, 4273.4444522212225, 4276.657867370603, 4281.229378711831, 4122.2579935611575, 4222.59885310895, 4231.090315582164, 4231.576842315759, 4233.343831706091, 4204.264253755596, 4210.0, 4213.241616509043, 4230.111676547928, 4235.385869048971, 3613.8012409317475, 3614.945775813365, 3615.692666123383, 3615.7649752766247, 3618.475321078429, 5447.891042179174, 5458.563314934796, 5458.590605704588, 5462.6995515246645, 5478.315210598676, 4869.4156701195725, 4874.390701162355, 4878.487758785312, 4880.731559764212, 4882.633802464829, 5674.3190817101795, 5752.712364381764, 5882.705864706748, 5908.763649454059, 5915.733791979371, 3882.7476214045996, 3918.666913312372, 3923.941140882889, 3924.391719283487, 3930.980345098285, 6106.0, 6169.2288463942, 6175.629462232236, 6234.127222188898, 6241.65670888101, 3921.039345360348, 3988.3219852625125, 3988.4615576897327, 3992.740471869319, 4003.719739618257, 4057.776822274744, 4072.1041370898356, 4096.549379568245, 4098.774567398762, 4102.50769907613, 4752.572268495852, 4771.73755443454, 4788.664793464493, 4793.880152996203, 4808.422989241313, 5900.380460051719, 5905.438983296666, 5906.527477801766, 5908.970455147783, 5926.525877929756, 1424.038773827683, 1432.44134787433, 1445.0390490324028, 1445.3929349673163, 1445.7180849734411, 937.8546325319586, 938.2728385501291, 940.7412961435523, 955.8279509688323, 963.4026903319987, 5122.462141475092, 5132.871678208, 5134.4352121267375, 5136.845894623168, 5163.251328557338, 6136.294326152461, 6137.60105593135, 6171.722272497748, 6190.50475961931, 6197.0, 5115.667481613683, 5132.255822905658, 5137.434882163034, 5137.563307118862, 5139.7687104080405, 3248.0, 3324.80051196929, 3336.299377130781, 3336.6830151135605, 3342.6824451677053, 5754.338251101093, 5755.568332375088, 5826.533877289807, 5826.563007774434, 5827.650340979555, 6379.74481020754, 6387.361263873576, 6397.52018598607, 6406.039094135824, 6422.068800023971, 5686.2039314496005, 5797.246357973437, 5823.4467725566, 5831.037878750044, 5832.912506312408, 6027.457528822427, 6150.1082343059115, 6216.844578885564, 6225.533085018551, 6264.091706702411, 6058.363871793398, 6060.393960603904, 6071.605345652519, 6074.848128796815, 6094.54290928191, 5824.970875145597, 5831.533477321889, 5833.504152146946, 5835.620684655484, 5840.795572154954, 3993.3610622300293, 4008.579099194543, 4081.4898137732785, 4089.7955102245364, 4092.8158232878995, 6201.286852012076, 6222.81331560054, 6235.875282494234, 6238.407351301619, 6245.406686364788, 5941.465268125889, 5960.165576819162, 5963.0459126539545, 5979.940200597938, 5987.730552125252, 5871.530277577869, 5932.584719069624, 5940.524758019262, 5988.071848863433, 6005.0, 5790.623609465371, 5797.449242321973, 5841.8539536510225, 5849.327327357239, 5851.678157701197, 5994.340622531605, 5999.5800293979, 6007.158997740407, 6024.246969128859, 6032.0, 5740.569457290637, 5818.970905145447, 5867.647941123546, 5874.794382196603, 5875.236219291465], "unit": "ms", "name": "prototype.html", "value": 4370.997400856427}, {"lowerIsBetter": false, "replicates": [715.9964200178998, 742.0029125347968, 767.2480968650722, 781.827997840475, 815.6533473273864, 11966.521339146435, 12450.875491245084, 12454.128211025232, 12558.05814563908, 12568.622941311753, 11680.357580333079, 11834.585789497369, 11843.230190037642, 11877.643670689893, 11896.10779191562, 784.3764207455073, 795.7016118955391, 802.6869520886859, 803.7186984555389, 806.7095845495617, 805.5649949027518, 806.105223202245, 811.0267678785451, 811.1645005644195, 812.1837553258966, 827.896512935883, 831.5426515416527, 835.6490274084899, 837.8282452097305, 840.0213750980131, 831.8045259364045, 832.950022998616, 833.6790335720731, 834.1075049696797, 834.837206744685, 613.6624856329001, 617.3147805935408, 618.935011823761, 619.7025427794683, 621.2172662445306, 11756.764864702744, 12500.874991250063, 12508.437120329607, 12557.811632825515, 12578.937105314506, 10545.0, 10756.73108172294, 10912.836307455394, 10937.890621093768, 11205.495752691148, 8844.778880527974, 9151.405158664666, 9155.862662060075, 9272.072792720674, 9557.90442095577, 3138.1213260287154, 3169.793963392372, 3182.3953448844877, 3237.2392487765355, 3246.902592922216, 41237.79381103105, 41518.0, 41887.0, 41924.58075419237, 41998.74003779922, 8656.39405241627, 8659.48043117415, 8730.257928076058, 8824.735257942144, 8839.116088391109, 15917.681646367007, 16084.839151608568, 16150.0, 16154.0, 16195.514134575982, 6160.10678451631, 6226.159468471789, 6255.74977000924, 6398.328175541501, 6514.543981921315, 3302.455094909361, 3338.7829791063505, 3386.2211691311136, 3410.556627638391, 3419.897403077912, 2610.0, 2620.4235068284947, 2639.1158961747647, 2640.1287575100173, 2658.1493921944793, 495.2422793126522, 498.0288437546798, 499.88752530680307, 504.70222568684653, 505.32539060354105, 457.5675986193016, 460.2038473440966, 500.3345550417935, 501.0930216308493, 558.6620094842643, 7010.193827709777, 7179.712811487587, 7221.0, 7233.638318084075, 7238.782836514913, 439.70759444968735, 479.4558176469732, 576.4120596991129, 610.8045425463898, 635.4598591197538, 3779.4897688812207, 3841.0, 3892.630200130983, 3928.371460566296, 3961.7622942623534, 47668.28497572539, 47719.522804772205, 48003.5199647999, 50961.49038509642, 51792.22311665328, 45150.77424612856, 45381.54618453839, 45445.318320225226, 45649.0, 45754.54245457569, 39740.60259397427, 40802.95985200728, 40900.181996359905, 41274.79362603168, 41280.967975800246, 7848.175941526058, 8004.479708818908, 8045.0, 8149.103598604031, 8258.050324212552, 30377.544336834522, 30945.690543094282, 31063.223419413793, 32164.678353217103, 32742.67257327396, 40071.0, 40539.0, 40693.79653101716, 41283.0, 41338.58661413348, 9829.950850245703, 9936.105750482491, 10162.847557286499, 10191.796164076824, 10480.68557943263, 10978.670639880816, 10995.230333876552, 11058.336499810037, 11662.825057624312, 12007.39963001829, 10288.0, 10984.121270298518, 11063.72340691489, 11167.553297868319, 11424.714382140513, 10296.536655850356, 10651.733706657085, 10999.450027498753, 11399.0, 11404.429778510876, 8972.28221742246, 9106.863397048917, 9176.632934682804, 9459.858102128612, 10064.748381290527, 8803.603837827184, 8834.867476987978, 8921.375503714678, 9008.41445306053, 9054.818903622023, 8716.215540601377, 8771.0, 8882.378233523592, 8903.643854245758, 8938.284937204879], "unit": "ms", "name": "yui.html", "value": 5686.540247392117}], "name": "dromaeo_css", "value": 6280.628694972656}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 112.0, 113.0, 113.0, 124.0, 111.0, 111.0, 111.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 152.0, 175.0, 143.0, 167.0, 152.0, 134.0, 176.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [162.0, 166.0, 166.0, 165.0, 164.0, 168.0, 165.0, 163.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 72.0, 74.0, 72.0, 137.0, 74.0, 74.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 130.0, 95.0, 96.0, 95.0, 131.0, 95.0, 95.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 149.0, 147.0, 149.0, 148.0, 147.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 75.0, 71.0, 70.0, 72.0, 73.0, 72.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 72.0, 70.0, 68.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 84.0, 85.0, 93.0, 84.0, 85.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [131.0, 129.0, 122.0, 121.0, 129.0, 130.0, 121.0, 124.0, 126.0, 140.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 144.0, 155.0, 154.0, 149.0, 146.0, 148.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [69.0, 72.0, 70.0, 69.0, 69.0, 70.0, 72.0, 69.0, 68.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1539.3}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [185.0481125092524], "unit": "score", "name": "DeltaBlue", "value": 357.3016719999998}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1078.7486515641856], "unit": "score", "name": "RayTrace", "value": 685.9698030000003}, {"lowerIsBetter": false, "replicates": [712.2507122507122], "unit": "score", "name": "Earley", "value": 935.7140519999998}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25500.0], "unit": "score", "name": "RegExp", "value": 35.72490196078431}, {"lowerIsBetter": false, "replicates": [580.3830528148578], "unit": "score", "name": "Splay", "value": 140.40899300000004}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21456.931725148257}]} 04:45:52 INFO - RETURN: dromaeo_css: 6280.63 04:45:52 INFO - RETURN: kraken: 1539.30 04:45:52 INFO - RETURN: v8_7: 21456.93 04:45:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21456.93"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1539.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6280.63"}}} 04:45:52 INFO - Return code: 0 04:45:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:45:52 INFO - # TBPL SUCCESS # 04:45:52 INFO - Running post-action listener: _resource_record_post_action 04:45:52 INFO - Running post-run listener: _resource_record_post_run 04:45:53 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 8192; Write bytes: 272609280; Read time: 164; Write time: 145652 04:45:53 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 774144; Read time: 0; Write time: 56 04:45:53 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 271835136; Read time: 164; Write time: 145596 04:45:53 INFO - Running post-run listener: _upload_blobber_files 04:45:53 INFO - Blob upload gear active. 04:45:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:45:53 INFO - Copying logs to upload dir... 04:45:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.666831 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-04 04:45:53.276383) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:45:53.279756) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009939 build_url: 'https://queue.taskcluster.net/v1/task/2TvPCx2PSs-JEljZ-vN7kg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 04:45:53.335188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:45:53.335850) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0c96bf5caf0e090009e1a122000001b2-1449228496.126726-86473781 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 04:45:53.389480) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:45:53.390075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 04:45:53.390664) ========= ========= Total master_lag: 0.24 =========