builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-037 starttime: 1449352913.88 results: success (0) buildid: 20151205122329 builduid: 1ca0b8ce67cb48548d4d133cec0f76e9 revision: fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:53.881343) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:53.882600) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:53.882969) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006485 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:53.924828) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:53.925176) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.002725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.003011) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004599 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.064777) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.065210) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.065708) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.066125) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-05 14:01:54-- 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% 43.1M=0s 2015-12-05 14:01:55 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176739 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.259453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.259898) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.310240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.310615) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 --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 fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 --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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-05 14:01:55,179 truncating revision to first 12 chars 2015-12-05 14:01:55,179 Setting DEBUG logging. 2015-12-05 14:01:55,179 attempt 1/10 2015-12-05 14:01:55,179 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fb4801cfdbbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-05 14:01:55,428 unpacking tar archive at: mozilla-central-fb4801cfdbbf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567827 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.893333) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.893633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.903464) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.903782) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-05 14:01:54.904210) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-05 14:01:54.904554) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:01:55 INFO - MultiFileLogger online at 20151205 14:01:55 in /builds/slave/test 14:01:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 14:01:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:55 INFO - {'append_to_log': False, 14:01:55 INFO - 'base_work_dir': '/builds/slave/test', 14:01:55 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:01:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:55 INFO - 'branch': 'Firefox-Non-PGO', 14:01:55 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:55 INFO - 'config_files': ('talos/linux_config.py',), 14:01:55 INFO - 'default_actions': ('clobber', 14:01:55 INFO - 'read-buildbot-config', 14:01:55 INFO - 'download-and-extract', 14:01:55 INFO - 'populate-webroot', 14:01:55 INFO - 'create-virtualenv', 14:01:55 INFO - 'install', 14:01:55 INFO - 'run-tests'), 14:01:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:55 INFO - 'download_minidump_stackwalk': True, 14:01:55 INFO - 'download_symbols': 'ondemand', 14:01:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:55 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:55 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:55 INFO - 'installer_path': 'installer.exe', 14:01:55 INFO - 'log_level': 'info', 14:01:55 INFO - 'log_name': 'talos', 14:01:55 INFO - 'log_to_console': True, 14:01:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:01:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:01:55 INFO - 'opt_config_files': (), 14:01:55 INFO - 'pip_index': False, 14:01:55 INFO - 'sps_profile': False, 14:01:55 INFO - 'sps_profile_interval': 0, 14:01:55 INFO - 'suite': 'dromaeojs', 14:01:55 INFO - 'system_bits': '64', 14:01:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:55 INFO - 'title': 'talos-linux64-ix-037', 14:01:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:55 INFO - 'use_talos_json': True, 14:01:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:55 INFO - 'work_dir': 'build'} 14:01:55 INFO - ##### 14:01:55 INFO - ##### Running clobber step. 14:01:55 INFO - ##### 14:01:55 INFO - Running pre-action listener: _resource_record_pre_action 14:01:55 INFO - Running main action method: clobber 14:01:55 INFO - rmtree: /builds/slave/test/build 14:01:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:56 INFO - Running post-action listener: _resource_record_post_action 14:01:56 INFO - ##### 14:01:56 INFO - ##### Running read-buildbot-config step. 14:01:56 INFO - ##### 14:01:56 INFO - Running pre-action listener: _resource_record_pre_action 14:01:56 INFO - Running main action method: read_buildbot_config 14:01:56 INFO - Using buildbot properties: 14:01:56 INFO - { 14:01:56 INFO - "properties": { 14:01:56 INFO - "buildnumber": 339, 14:01:56 INFO - "product": "firefox", 14:01:56 INFO - "script_repo_revision": "production", 14:01:56 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:01:56 INFO - "repository": "", 14:01:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:01:56 INFO - "buildid": "20151205122329", 14:01:56 INFO - "slavename": "talos-linux64-ix-037", 14:01:56 INFO - "pgo_build": "False", 14:01:56 INFO - "basedir": "/builds/slave/test", 14:01:56 INFO - "project": "", 14:01:56 INFO - "platform": "ubuntu64_hw", 14:01:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:01:56 INFO - "slavebuilddir": "test", 14:01:56 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:01:56 INFO - "branch": "mozilla-central", 14:01:56 INFO - "repo_path": "mozilla-central", 14:01:56 INFO - "stage_platform": "linux64", 14:01:56 INFO - "builduid": "1ca0b8ce67cb48548d4d133cec0f76e9", 14:01:56 INFO - "revision": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960" 14:01:56 INFO - }, 14:01:56 INFO - "sourcestamp": { 14:01:56 INFO - "repository": "", 14:01:56 INFO - "hasPatch": false, 14:01:56 INFO - "project": "", 14:01:56 INFO - "branch": "mozilla-central-linux64-talos", 14:01:56 INFO - "changes": [ 14:01:56 INFO - { 14:01:56 INFO - "category": null, 14:01:56 INFO - "files": [ 14:01:56 INFO - { 14:01:56 INFO - "url": null, 14:01:56 INFO - "name": "https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 14:01:56 INFO - } 14:01:56 INFO - ], 14:01:56 INFO - "repository": "", 14:01:56 INFO - "rev": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960", 14:01:56 INFO - "who": "ryanvm@gmail.com", 14:01:56 INFO - "when": 1449352906, 14:01:56 INFO - "number": 6802349, 14:01:56 INFO - "comments": "Merge b2g-inbound to m-c. a=merge", 14:01:56 INFO - "project": "", 14:01:56 INFO - "at": "Sat 05 Dec 2015 14:01:46", 14:01:56 INFO - "branch": "mozilla-central-linux64-talos", 14:01:56 INFO - "revlink": "", 14:01:56 INFO - "properties": [ 14:01:56 INFO - [ 14:01:56 INFO - "buildid", 14:01:56 INFO - "20151205122329", 14:01:56 INFO - "Change" 14:01:56 INFO - ], 14:01:56 INFO - [ 14:01:56 INFO - "builduid", 14:01:56 INFO - "1ca0b8ce67cb48548d4d133cec0f76e9", 14:01:56 INFO - "Change" 14:01:56 INFO - ], 14:01:56 INFO - [ 14:01:56 INFO - "pgo_build", 14:01:56 INFO - "False", 14:01:56 INFO - "Change" 14:01:56 INFO - ] 14:01:56 INFO - ], 14:01:56 INFO - "revision": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960" 14:01:56 INFO - } 14:01:56 INFO - ], 14:01:56 INFO - "revision": "fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960" 14:01:56 INFO - } 14:01:56 INFO - } 14:01:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 14:01:56 INFO - Running post-action listener: _resource_record_post_action 14:01:56 INFO - ##### 14:01:56 INFO - ##### Running download-and-extract step. 14:01:56 INFO - ##### 14:01:56 INFO - Running pre-action listener: _resource_record_pre_action 14:01:56 INFO - Running main action method: download_and_extract 14:01:56 INFO - mkdir: /builds/slave/test/build/tests 14:01:56 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')]} 14:01:56 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:01:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json 14:01:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json 14:01:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:01:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:02:01 INFO - Downloaded 1302 bytes. 14:02:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:02:01 INFO - Using the following test package requirements: 14:02:01 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:01 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:02:01 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'jsshell-linux-x86_64.zip'], 14:02:01 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:02:01 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:01 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:02:01 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:02:01 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:02:01 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 14:02:01 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 14:02:01 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:02:01 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:02:01 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')]} 14:02:01 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:07 INFO - Downloaded 21848971 bytes. 14:02:07 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 14:02:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:07 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 14:02:08 INFO - Return code: 0 14:02:08 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 14:02:08 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')]} 14:02:08 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:02:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:10 INFO - Downloaded 21848971 bytes. 14:02:10 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 14:02:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 14:02:10 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 14:02:11 INFO - Return code: 0 14:02:11 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')]} 14:02:11 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:02:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:12 INFO - Downloaded 11132001 bytes. 14:02:12 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 14:02:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 14:02:12 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 14:02:12 INFO - Return code: 0 14:02: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')]} 14:02:12 INFO - https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:02:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eIQz-KcRSNmVftlBrB18tQ/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 14:02:13 INFO - Downloaded 57708588 bytes. 14:02:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:13 INFO - mkdir: /builds/slave/test/properties 14:02:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:02:13 INFO - Writing to file /builds/slave/test/properties/build_url 14:02:13 INFO - Contents: 14:02:13 INFO - build_url:https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 14:02:13 INFO - Running post-action listener: _resource_record_post_action 14:02:13 INFO - Running post-action listener: set_extra_try_arguments 14:02:13 INFO - ##### 14:02:13 INFO - ##### Running populate-webroot step. 14:02:13 INFO - ##### 14:02:13 INFO - Running pre-action listener: _resource_record_pre_action 14:02:13 INFO - Running main action method: populate_webroot 14:02:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:02:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:02:13 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:02:13 INFO - '../fennec_ids.txt'], 14:02:13 INFO - 'tests': ['tcheck2']}, 14:02:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:02:13 INFO - '--tppagecycles', 14:02:13 INFO - '7'], 14:02:13 INFO - 'tests': ['tsvgm']}}, 14:02:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:02:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:02:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:02:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:02:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:02:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:13 INFO - 'talos_options': ['--e10s'], 14:02:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:02:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:13 INFO - 'tests': ['damp', 'tps']}, 14:02:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:13 INFO - 'talos_options': ['--e10s'], 14:02:13 INFO - 'tests': ['damp', 'tps']}, 14:02:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:02:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:02:13 INFO - 'other': {'tests': ['a11yr', 14:02:14 INFO - 'ts_paint', 14:02:14 INFO - 'tpaint', 14:02:14 INFO - 'sessionrestore', 14:02:14 INFO - 'sessionrestore_no_auto_restore']}, 14:02:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:02:14 INFO - 'tests': ['a11yr', 14:02:14 INFO - 'ts_paint', 14:02:14 INFO - 'tpaint', 14:02:14 INFO - 'sessionrestore', 14:02:14 INFO - 'sessionrestore_no_auto_restore']}, 14:02:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:02:14 INFO - 'tests': ['a11yr', 14:02:14 INFO - 'ts_paint', 14:02:14 INFO - 'tpaint', 14:02:14 INFO - 'sessionrestore', 14:02:14 INFO - 'sessionrestore_no_auto_restore']}, 14:02:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:02:14 INFO - 'tests': ['a11yr', 14:02:14 INFO - 'ts_paint', 14:02:14 INFO - 'tpaint', 14:02:14 INFO - 'sessionrestore', 14:02:14 INFO - 'sessionrestore_no_auto_restore']}, 14:02:14 INFO - 'other_l64': {'tests': ['a11yr', 14:02:14 INFO - 'ts_paint', 14:02:14 INFO - 'tpaint', 14:02:14 INFO - 'sessionrestore', 14:02:14 INFO - 'sessionrestore_no_auto_restore']}, 14:02:14 INFO - 'other_nol64': {'tests': ['a11yr', 14:02:14 INFO - 'ts_paint', 14:02:14 INFO - 'tpaint', 14:02:14 INFO - 'sessionrestore', 14:02:14 INFO - 'sessionrestore_no_auto_restore']}, 14:02:14 INFO - 'svgr': {'tests': ['tsvgx', 14:02:14 INFO - 'tsvgr_opacity', 14:02:14 INFO - 'tart', 14:02:14 INFO - 'tscrollx', 14:02:14 INFO - 'cart']}, 14:02:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:02:14 INFO - 'tests': ['tsvgx', 14:02:14 INFO - 'tsvgr_opacity', 14:02:14 INFO - 'tart', 14:02:14 INFO - 'tscrollx', 14:02:14 INFO - 'cart']}, 14:02:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:14 INFO - 'tests': ['tp5o']}, 14:02:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:14 INFO - 'talos_options': ['--e10s'], 14:02:14 INFO - 'tests': ['tp5o']}, 14:02:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:14 INFO - 'talos_options': ['--xperf_path', 14:02:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:14 INFO - 'tests': ['tp5n']}, 14:02:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:02:14 INFO - 'talos_options': ['--e10s', 14:02:14 INFO - '--xperf_path', 14:02:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:02:14 INFO - 'tests': ['tp5n']}}, 14:02:14 INFO - 'talos.zip': {'path': '', 14:02:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:02:14 INFO - Running post-action listener: _resource_record_post_action 14:02:14 INFO - ##### 14:02:14 INFO - ##### Running create-virtualenv step. 14:02:14 INFO - ##### 14:02:14 INFO - Running pre-action listener: _resource_record_pre_action 14:02:14 INFO - Running main action method: create_virtualenv 14:02:14 INFO - Creating virtualenv /builds/slave/test/build/venv 14:02:14 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 14:02:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:02:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:02:14 INFO - Using real prefix '/usr' 14:02:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:02:14 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:16 INFO - Installing pip.................done. 14:02:16 INFO - Return code: 0 14:02:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:16 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')]} 14:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:16 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')]} 14:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:16 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:16 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 14:02:16 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 14:02:16 INFO - Using env: {'DISPLAY': ':0', 14:02:16 INFO - 'HOME': '/home/cltbld', 14:02:16 INFO - 'LANG': 'en_US.UTF-8', 14:02:16 INFO - 'LANGUAGE': 'en_US:en', 14:02:16 INFO - 'LOGNAME': 'cltbld', 14:02:16 INFO - 'MAIL': '/var/mail/cltbld', 14:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:16 INFO - 'MOZ_NO_REMOTE': '1', 14:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:16 INFO - 'NO_EM_RESTART': '1', 14:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:16 INFO - 'PWD': '/builds/slave/test', 14:02:16 INFO - 'SHELL': '/bin/bash', 14:02:16 INFO - 'SHLVL': '1', 14:02:16 INFO - 'TERM': 'linux', 14:02:16 INFO - 'TMOUT': '86400', 14:02:16 INFO - 'USER': 'cltbld', 14:02:16 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:16 INFO - '_': '/tools/buildbot/bin/python'} 14:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:16 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 14:02:16 INFO - Cleaning up... 14:02:16 INFO - Return code: 0 14:02:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:02:16 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')]} 14:02:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:16 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')]} 14:02:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:16 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:16 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 14:02:16 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 14:02:16 INFO - Using env: {'DISPLAY': ':0', 14:02:16 INFO - 'HOME': '/home/cltbld', 14:02:16 INFO - 'LANG': 'en_US.UTF-8', 14:02:16 INFO - 'LANGUAGE': 'en_US:en', 14:02:16 INFO - 'LOGNAME': 'cltbld', 14:02:16 INFO - 'MAIL': '/var/mail/cltbld', 14:02:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:16 INFO - 'MOZ_NO_REMOTE': '1', 14:02:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:16 INFO - 'NO_EM_RESTART': '1', 14:02:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:16 INFO - 'PWD': '/builds/slave/test', 14:02:16 INFO - 'SHELL': '/bin/bash', 14:02:16 INFO - 'SHLVL': '1', 14:02:16 INFO - 'TERM': 'linux', 14:02:16 INFO - 'TMOUT': '86400', 14:02:16 INFO - 'USER': 'cltbld', 14:02:16 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:16 INFO - '_': '/tools/buildbot/bin/python'} 14:02:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:16 INFO - Downloading/unpacking psutil>=0.7.1 14:02:16 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 14:02:16 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 14:02:16 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 14:02:16 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 14:02:16 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 14:02:16 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 14:02:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 14:02:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:02:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:18 INFO - Installing collected packages: psutil 14:02:18 INFO - Running setup.py install for psutil 14:02:18 INFO - building 'psutil._psutil_linux' extension 14:02:18 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 14:02:19 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 14:02:19 INFO - building 'psutil._psutil_posix' extension 14:02:19 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 14:02:19 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 14:02:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:19 INFO - Successfully installed psutil 14:02:19 INFO - Cleaning up... 14:02:19 INFO - Return code: 0 14:02:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:02:19 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')]} 14:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 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')]} 14:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:19 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:19 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 14:02:19 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 14:02:19 INFO - Using env: {'DISPLAY': ':0', 14:02:19 INFO - 'HOME': '/home/cltbld', 14:02:19 INFO - 'LANG': 'en_US.UTF-8', 14:02:19 INFO - 'LANGUAGE': 'en_US:en', 14:02:19 INFO - 'LOGNAME': 'cltbld', 14:02:19 INFO - 'MAIL': '/var/mail/cltbld', 14:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:19 INFO - 'MOZ_NO_REMOTE': '1', 14:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:19 INFO - 'NO_EM_RESTART': '1', 14:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:19 INFO - 'PWD': '/builds/slave/test', 14:02:19 INFO - 'SHELL': '/bin/bash', 14:02:19 INFO - 'SHLVL': '1', 14:02:19 INFO - 'TERM': 'linux', 14:02:19 INFO - 'TMOUT': '86400', 14:02:19 INFO - 'USER': 'cltbld', 14:02:19 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:19 INFO - '_': '/tools/buildbot/bin/python'} 14:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:02:19 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 14:02:19 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 14:02:19 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 14:02:19 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 14:02:19 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 14:02:19 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 14:02:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:02:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:02:21 INFO - Installing collected packages: mozsystemmonitor 14:02:21 INFO - Running setup.py install for mozsystemmonitor 14:02:21 INFO - Successfully installed mozsystemmonitor 14:02:21 INFO - Cleaning up... 14:02:21 INFO - Return code: 0 14:02:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:21 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')]} 14:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:21 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')]} 14:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:21 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:21 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 14:02:21 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 14:02:21 INFO - Using env: {'DISPLAY': ':0', 14:02:21 INFO - 'HOME': '/home/cltbld', 14:02:21 INFO - 'LANG': 'en_US.UTF-8', 14:02:21 INFO - 'LANGUAGE': 'en_US:en', 14:02:21 INFO - 'LOGNAME': 'cltbld', 14:02:21 INFO - 'MAIL': '/var/mail/cltbld', 14:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:21 INFO - 'MOZ_NO_REMOTE': '1', 14:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:21 INFO - 'NO_EM_RESTART': '1', 14:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:21 INFO - 'PWD': '/builds/slave/test', 14:02:21 INFO - 'SHELL': '/bin/bash', 14:02:21 INFO - 'SHLVL': '1', 14:02:21 INFO - 'TERM': 'linux', 14:02:21 INFO - 'TMOUT': '86400', 14:02:21 INFO - 'USER': 'cltbld', 14:02:21 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:21 INFO - '_': '/tools/buildbot/bin/python'} 14:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:21 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:21 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 14:02:21 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 14:02:21 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 14:02:21 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 14:02:21 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 14:02:21 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 14:02:23 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 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 14:02:23 INFO - Downloading docopt-0.6.1.tar.gz 14:02:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:23 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:23 INFO - Running setup.py install for blobuploader 14:02:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:24 INFO - Running setup.py install for requests 14:02:24 INFO - Running setup.py install for docopt 14:02:24 INFO - Successfully installed blobuploader requests docopt 14:02:24 INFO - Cleaning up... 14:02:24 INFO - Return code: 0 14:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:24 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')]} 14:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 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')]} 14:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:24 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 14:02:24 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 14:02:24 INFO - Using env: {'DISPLAY': ':0', 14:02:24 INFO - 'HOME': '/home/cltbld', 14:02:24 INFO - 'LANG': 'en_US.UTF-8', 14:02:24 INFO - 'LANGUAGE': 'en_US:en', 14:02:24 INFO - 'LOGNAME': 'cltbld', 14:02:24 INFO - 'MAIL': '/var/mail/cltbld', 14:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:24 INFO - 'MOZ_NO_REMOTE': '1', 14:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:24 INFO - 'NO_EM_RESTART': '1', 14:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:24 INFO - 'PWD': '/builds/slave/test', 14:02:24 INFO - 'SHELL': '/bin/bash', 14:02:24 INFO - 'SHLVL': '1', 14:02:24 INFO - 'TERM': 'linux', 14:02:24 INFO - 'TMOUT': '86400', 14:02:24 INFO - 'USER': 'cltbld', 14:02:24 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:24 INFO - '_': '/tools/buildbot/bin/python'} 14:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:24 INFO - Running setup.py (path:/tmp/pip-CXgQX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:24 INFO - Running setup.py (path:/tmp/pip-x_Rd3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:24 INFO - Running setup.py (path:/tmp/pip-Wl29E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:25 INFO - Running setup.py (path:/tmp/pip-zQMtwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:25 INFO - Running setup.py (path:/tmp/pip-oH04iK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:25 INFO - Running setup.py (path:/tmp/pip-UxPTIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:25 INFO - Running setup.py (path:/tmp/pip-9kJvC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:25 INFO - Running setup.py (path:/tmp/pip-1IW4Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:25 INFO - Running setup.py (path:/tmp/pip-Ucgvjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:25 INFO - Running setup.py (path:/tmp/pip-8AHfbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:25 INFO - Running setup.py (path:/tmp/pip-aHNGrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:25 INFO - Running setup.py (path:/tmp/pip-x7wK4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:25 INFO - Running setup.py (path:/tmp/pip-N7jydC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:25 INFO - Running setup.py (path:/tmp/pip-oKb7aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:25 INFO - Running setup.py (path:/tmp/pip-6plNVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:25 INFO - Running setup.py (path:/tmp/pip-rBAcp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:25 INFO - Running setup.py (path:/tmp/pip-s5Ybm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:26 INFO - Running setup.py install for manifestparser 14:02:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Running setup.py install for mozcrash 14:02:26 INFO - Running setup.py install for mozdebug 14:02:26 INFO - Running setup.py install for mozdevice 14:02:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Running setup.py install for mozfile 14:02:26 INFO - Running setup.py install for mozhttpd 14:02:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Running setup.py install for mozinfo 14:02:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Running setup.py install for mozInstall 14:02:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:26 INFO - Running setup.py install for mozleak 14:02:26 INFO - Running setup.py install for mozlog 14:02:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Running setup.py install for moznetwork 14:02:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Running setup.py install for mozprocess 14:02:27 INFO - Running setup.py install for mozprofile 14:02:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Running setup.py install for mozrunner 14:02:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Running setup.py install for mozscreenshot 14:02:27 INFO - Running setup.py install for moztest 14:02:27 INFO - Running setup.py install for mozversion 14:02:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:27 INFO - Cleaning up... 14:02:27 INFO - Return code: 0 14:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:27 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')]} 14:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:27 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')]} 14:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:27 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:27 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 14:02:27 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 14:02:27 INFO - Using env: {'DISPLAY': ':0', 14:02:27 INFO - 'HOME': '/home/cltbld', 14:02:27 INFO - 'LANG': 'en_US.UTF-8', 14:02:27 INFO - 'LANGUAGE': 'en_US:en', 14:02:27 INFO - 'LOGNAME': 'cltbld', 14:02:27 INFO - 'MAIL': '/var/mail/cltbld', 14:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:27 INFO - 'MOZ_NO_REMOTE': '1', 14:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:27 INFO - 'NO_EM_RESTART': '1', 14:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:27 INFO - 'PWD': '/builds/slave/test', 14:02:27 INFO - 'SHELL': '/bin/bash', 14:02:27 INFO - 'SHLVL': '1', 14:02:27 INFO - 'TERM': 'linux', 14:02:27 INFO - 'TMOUT': '86400', 14:02:27 INFO - 'USER': 'cltbld', 14:02:27 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:27 INFO - '_': '/tools/buildbot/bin/python'} 14:02:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:28 INFO - Running setup.py (path:/tmp/pip-yALvVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:28 INFO - Running setup.py (path:/tmp/pip-VE5giZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:28 INFO - Running setup.py (path:/tmp/pip-Hkz_z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:28 INFO - Running setup.py (path:/tmp/pip-83GXgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:28 INFO - Running setup.py (path:/tmp/pip-DTERHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:28 INFO - Running setup.py (path:/tmp/pip-3KHiGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:28 INFO - Running setup.py (path:/tmp/pip-Do11We-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:28 INFO - Running setup.py (path:/tmp/pip-nZe7vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:28 INFO - Running setup.py (path:/tmp/pip-450YVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:28 INFO - Running setup.py (path:/tmp/pip-tXF4bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:28 INFO - Running setup.py (path:/tmp/pip-1rBHAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:28 INFO - Running setup.py (path:/tmp/pip-jGlKMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:28 INFO - Running setup.py (path:/tmp/pip-7rL6K0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:28 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)) 14:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:29 INFO - Running setup.py (path:/tmp/pip-lxN8rx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:29 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)) 14:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:29 INFO - Running setup.py (path:/tmp/pip-o9uEBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:29 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)) 14:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:29 INFO - Running setup.py (path:/tmp/pip-gNj2Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:29 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)) 14:02:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:29 INFO - Running setup.py (path:/tmp/pip-YHg_ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:29 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)) 14:02:29 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)) 14:02:29 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)) 14:02:29 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)) 14:02:29 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)) 14:02:29 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)) 14:02:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:29 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 14:02:29 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 14:02:29 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 14:02:29 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 14:02:29 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 14:02:29 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 14:02:30 INFO - Downloading blessings-1.5.1.tar.gz 14:02:30 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 14:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:31 INFO - Installing collected packages: blessings 14:02:31 INFO - Running setup.py install for blessings 14:02:31 INFO - Successfully installed blessings 14:02:31 INFO - Cleaning up... 14:02:31 INFO - Return code: 0 14:02:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Current package versions: 14:02:31 INFO - argparse == 1.2.1 14:02:31 INFO - blessings == 1.5.1 14:02:31 INFO - blobuploader == 1.2.4 14:02:31 INFO - docopt == 0.6.1 14:02:31 INFO - manifestparser == 1.1 14:02:31 INFO - mozInstall == 1.12 14:02:31 INFO - mozcrash == 0.16 14:02:31 INFO - mozdebug == 0.1 14:02:31 INFO - mozdevice == 0.47 14:02:31 INFO - mozfile == 1.2 14:02:31 INFO - mozhttpd == 0.7 14:02:31 INFO - mozinfo == 0.9 14:02:31 INFO - mozleak == 0.1 14:02:31 INFO - mozlog == 3.1 14:02:31 INFO - moznetwork == 0.27 14:02:31 INFO - mozprocess == 0.22 14:02:31 INFO - mozprofile == 0.27 14:02:31 INFO - mozrunner == 6.11 14:02:31 INFO - mozscreenshot == 0.1 14:02:31 INFO - mozsystemmonitor == 0.0 14:02:31 INFO - moztest == 0.7 14:02:31 INFO - mozversion == 1.4 14:02:31 INFO - psutil == 3.1.1 14:02:31 INFO - requests == 1.2.3 14:02:31 INFO - wsgiref == 0.1.2 14:02:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:31 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')]} 14:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:31 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')]} 14:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:31 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:31 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 14:02:31 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 14:02:31 INFO - Using env: {'DISPLAY': ':0', 14:02:31 INFO - 'HOME': '/home/cltbld', 14:02:31 INFO - 'LANG': 'en_US.UTF-8', 14:02:31 INFO - 'LANGUAGE': 'en_US:en', 14:02:31 INFO - 'LOGNAME': 'cltbld', 14:02:31 INFO - 'MAIL': '/var/mail/cltbld', 14:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:31 INFO - 'MOZ_NO_REMOTE': '1', 14:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:31 INFO - 'NO_EM_RESTART': '1', 14:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:31 INFO - 'PWD': '/builds/slave/test', 14:02:31 INFO - 'SHELL': '/bin/bash', 14:02:31 INFO - 'SHLVL': '1', 14:02:31 INFO - 'TERM': 'linux', 14:02:31 INFO - 'TMOUT': '86400', 14:02:31 INFO - 'USER': 'cltbld', 14:02:31 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:31 INFO - '_': '/tools/buildbot/bin/python'} 14:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 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)) 14:02:31 INFO - Cleaning up... 14:02:31 INFO - Return code: 0 14:02:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02:31 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')]} 14:02:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:31 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')]} 14:02:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:31 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:31 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 14:02:31 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 14:02:31 INFO - Using env: {'DISPLAY': ':0', 14:02:31 INFO - 'HOME': '/home/cltbld', 14:02:31 INFO - 'LANG': 'en_US.UTF-8', 14:02:31 INFO - 'LANGUAGE': 'en_US:en', 14:02:31 INFO - 'LOGNAME': 'cltbld', 14:02:31 INFO - 'MAIL': '/var/mail/cltbld', 14:02:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:31 INFO - 'MOZ_NO_REMOTE': '1', 14:02:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:31 INFO - 'NO_EM_RESTART': '1', 14:02:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:31 INFO - 'PWD': '/builds/slave/test', 14:02:31 INFO - 'SHELL': '/bin/bash', 14:02:31 INFO - 'SHLVL': '1', 14:02:31 INFO - 'TERM': 'linux', 14:02:31 INFO - 'TMOUT': '86400', 14:02:31 INFO - 'USER': 'cltbld', 14:02:31 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:31 INFO - '_': '/tools/buildbot/bin/python'} 14:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:31 INFO - Downloading/unpacking jsonschema 14:02:31 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 14:02:31 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 14:02:31 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 14:02:31 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 14:02:31 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 14:02:31 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 14:02:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:33 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 14:02:33 INFO - Downloading/unpacking functools32 (from jsonschema) 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 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 14:02:33 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:02:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:33 INFO - warning: no files found matching '*.txt' 14:02:33 INFO - no previously-included directories found matching 'build' 14:02:33 INFO - no previously-included directories found matching 'dist' 14:02:33 INFO - no previously-included directories found matching '.git*' 14:02:33 INFO - Installing collected packages: jsonschema, functools32 14:02:33 INFO - Running setup.py install for functools32 14:02:33 INFO - warning: no files found matching '*.txt' 14:02:33 INFO - no previously-included directories found matching 'build' 14:02:33 INFO - no previously-included directories found matching 'dist' 14:02:33 INFO - no previously-included directories found matching '.git*' 14:02:33 INFO - Successfully installed jsonschema functools32 14:02:33 INFO - Cleaning up... 14:02:33 INFO - Return code: 0 14:02:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:02:33 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')]} 14:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 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')]} 14:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:33 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 0x7fc495c94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b53240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, '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': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', '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 14:02:33 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 14:02:33 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 14:02:33 INFO - Using env: {'DISPLAY': ':0', 14:02:33 INFO - 'HOME': '/home/cltbld', 14:02:33 INFO - 'LANG': 'en_US.UTF-8', 14:02:33 INFO - 'LANGUAGE': 'en_US:en', 14:02:33 INFO - 'LOGNAME': 'cltbld', 14:02:33 INFO - 'MAIL': '/var/mail/cltbld', 14:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:33 INFO - 'MOZ_NO_REMOTE': '1', 14:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:33 INFO - 'NO_EM_RESTART': '1', 14:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:33 INFO - 'PWD': '/builds/slave/test', 14:02:33 INFO - 'SHELL': '/bin/bash', 14:02:33 INFO - 'SHLVL': '1', 14:02:33 INFO - 'TERM': 'linux', 14:02:33 INFO - 'TMOUT': '86400', 14:02:33 INFO - 'USER': 'cltbld', 14:02:33 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:33 INFO - '_': '/tools/buildbot/bin/python'} 14:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:34 INFO - Downloading/unpacking flake8 14:02:34 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 14:02:34 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 14:02:34 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 14:02:34 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 14:02:34 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 14:02:34 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 14:02:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:02:35 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 14:02:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:02:35 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 14:02:35 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 14:02:35 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 14:02:35 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 14:02:35 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 14:02:35 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 14:02:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:02:36 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 14:02:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 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 14:02:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:02:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:36 INFO - no previously-included directories found matching 'docs/_build' 14:02:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:02:36 INFO - Running setup.py install for pep8 14:02:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:02:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:02:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:02:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:02:36 INFO - no previously-included directories found matching 'docs/_build' 14:02:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:02:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:02:36 INFO - Cleaning up... 14:02:36 INFO - Return code: 0 14:02:36 INFO - Running post-action listener: _resource_record_post_action 14:02:36 INFO - Running post-action listener: _start_resource_monitoring 14:02:36 INFO - Starting resource monitoring. 14:02:36 INFO - ##### 14:02:36 INFO - ##### Running install step. 14:02:36 INFO - ##### 14:02:36 INFO - Running pre-action listener: _resource_record_pre_action 14:02:36 INFO - Running main action method: install 14:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:36 INFO - Reading from file tmpfile_stdout 14:02:36 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:37 INFO - Reading from file tmpfile_stdout 14:02:37 INFO - Output received: 14:02:37 INFO - Usage: mozinstall [options] installer 14:02:37 INFO - Options: 14:02:37 INFO - -h, --help show this help message and exit 14:02:37 INFO - -d DEST, --destination=DEST 14:02:37 INFO - Directory to install application into. [default: 14:02:37 INFO - "/builds/slave/test"] 14:02:37 INFO - --app=APP Application being installed. [default: firefox] 14:02:37 INFO - mkdir: /builds/slave/test/build/application 14:02:37 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'] 14:02:37 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 14:02:51 INFO - Reading from file tmpfile_stdout 14:02:51 INFO - Output received: 14:02:51 INFO - /builds/slave/test/build/application/firefox/firefox 14:02:51 INFO - Running post-action listener: _resource_record_post_action 14:02:51 INFO - ##### 14:02:51 INFO - ##### Running run-tests step. 14:02:51 INFO - ##### 14:02:51 INFO - Running pre-action listener: _resource_record_pre_action 14:02:51 INFO - Running main action method: run_tests 14:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:02:51 INFO - Python 2.7.3 14:02:51 INFO - Return code: 0 14:02:51 INFO - grabbing minidump binary from tooltool 14:02:51 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')]} 14:02:51 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 0x1be20b0>, '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 0x1be2fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1be3440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:02:51 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 14:02:51 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 14:02:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:51 INFO - Return code: 0 14:02:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:02:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:02:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:02:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:02:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:02:52 INFO - Return code: 0 14:02:52 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] in /builds/slave/test/build 14:02:52 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost 14:02:52 INFO - Using env: {'DISPLAY': ':0', 14:02:52 INFO - 'HOME': '/home/cltbld', 14:02:52 INFO - 'LANG': 'en_US.UTF-8', 14:02:52 INFO - 'LANGUAGE': 'en_US:en', 14:02:52 INFO - 'LOGNAME': 'cltbld', 14:02:52 INFO - 'MAIL': '/var/mail/cltbld', 14:02:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:02:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:52 INFO - 'MOZ_NO_REMOTE': '1', 14:02:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:02:52 INFO - 'NO_EM_RESTART': '1', 14:02:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:52 INFO - 'PWD': '/builds/slave/test', 14:02:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:02:52 INFO - 'SHELL': '/bin/bash', 14:02:52 INFO - 'SHLVL': '1', 14:02:52 INFO - 'TERM': 'linux', 14:02:52 INFO - 'TMOUT': '86400', 14:02:52 INFO - 'USER': 'cltbld', 14:02:52 INFO - 'XDG_SESSION_COOKIE': '6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521', 14:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:52 INFO - '_': '/tools/buildbot/bin/python'} 14:02:52 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost'] with output_timeout 3600 14:02:52 INFO - mozversion INFO | application_buildid: 20151205122329 14:02:52 INFO - mozversion INFO | application_changeset: fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 14:02:52 INFO - mozversion INFO | application_display_name: Nightly 14:02:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:52 INFO - mozversion INFO | application_name: Firefox 14:02:52 INFO - mozversion INFO | application_remotingname: firefox 14:02:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 14:02:52 INFO - mozversion INFO | application_vendor: Mozilla 14:02:52 INFO - mozversion INFO | application_version: 45.0a1 14:02:52 INFO - mozversion INFO | platform_buildid: 20151205122329 14:02:52 INFO - mozversion INFO | platform_changeset: fb4801cfdbbf072a071f6a6ef8c1cf13dd6de960 14:02:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 14:02:52 INFO - mozversion INFO | platform_version: 45.0a1 14:02:52 INFO - 2015-12-05 14:02:52,827 DEBUG : using testdate: 1449352972 14:02:52 INFO - 2015-12-05 14:02:52,827 DEBUG : actual date: 1449352972 14:02:52 INFO - 2015-12-05 14:02:52,834 INFO : starting webserver on 'localhost:58240' 14:02:52 INFO - 2015-12-05 14:02:52,835 INFO : Starting test suite talos-linux64-ix-037 14:02:52 INFO - 2015-12-05 14:02:52,835 INFO : Starting test dromaeo_css 14:02:52 INFO - 2015-12-05 14:02:52,835 DEBUG : operating with platform_type : linux_ 14:02:52 INFO - 2015-12-05 14:02:52,835 INFO : Initialising browser for dromaeo_css test... 14:02:52 INFO - 2015-12-05 14:02:52,843 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMPhWw/profile http://localhost:58240/getInfo.html 14:02:56 INFO - 2015-12-05 14:02:56,917 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:02:56 INFO - 2015-12-05 14:02:56,917 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:02:56 INFO - 2015-12-05 14:02:56,917 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:02:56 INFO - 2015-12-05 14:02:56,917 DEBUG : BROWSER_OUTPUT: __metrics 14:02:57 INFO - 2015-12-05 14:02:57,175 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] 14:02:57 INFO - 2015-12-05 14:02:57,243 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:58 INFO - 2015-12-05 14:02:58,413 INFO : Browser initialized. 14:02:58 INFO - 2015-12-05 14:02:58,414 INFO : Running cycle 1/1 for dromaeo_css test... 14:02:58 INFO - 2015-12-05 14:02:58,414 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNMPhWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:03:10 INFO - 2015-12-05 14:03:10,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 142790656 14:03:10 INFO - 2015-12-05 14:03:10,434 DEBUG : BROWSER_OUTPUT: 14:04:02 INFO - 2015-12-05 14:04:02,180 DEBUG : BROWSER_OUTPUT: 1449353042174 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] 14:06:14 INFO - 2015-12-05 14:06:14,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58240/tests/dromaeo/cssquery-ext.html) 14:06:15 INFO - 2015-12-05 14:06:15,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 246157312 14:06:15 INFO - 2015-12-05 14:06:15,435 DEBUG : BROWSER_OUTPUT: 14:09:17 INFO - 2015-12-05 14:09:17,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-ext.html (next: http://localhost:58240/tests/dromaeo/cssquery-jquery.html) 14:09:18 INFO - 2015-12-05 14:09:18,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 209178624 14:09:18 INFO - 2015-12-05 14:09:18,506 DEBUG : BROWSER_OUTPUT: 14:12:20 INFO - 2015-12-05 14:12:20,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58240/tests/dromaeo/cssquery-mootools.html) 14:12:21 INFO - 2015-12-05 14:12:21,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 214233088 14:12:21 INFO - 2015-12-05 14:12:21,122 DEBUG : BROWSER_OUTPUT: 14:15:23 INFO - 2015-12-05 14:15:23,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58240/tests/dromaeo/cssquery-prototype.html) 14:15:23 INFO - 2015-12-05 14:15:23,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 202784768 14:15:23 INFO - 2015-12-05 14:15:23,681 DEBUG : BROWSER_OUTPUT: 14:18:26 INFO - 2015-12-05 14:18:26,293 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58240/tests/dromaeo/cssquery-yui.html) 14:18:26 INFO - 2015-12-05 14:18:26,895 DEBUG : BROWSER_OUTPUT: RSS: Main: 206061568 14:18:26 INFO - 2015-12-05 14:18:26,895 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/dromaeo/cssquery-yui.html (next: http://localhost:58240/tests/dromaeo/cssquery-dojo.html) 14:21:29 INFO - 2015-12-05 14:21:29,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 249757696 14:21:29 INFO - 2015-12-05 14:21:29,933 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,933 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:21:29 INFO - 2015-12-05 14:21:29,933 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:21:29 INFO - 2015-12-05 14:21:29,933 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:21:29 INFO - 2015-12-05 14:21:29,933 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:21:29 INFO - 2015-12-05 14:21:29,933 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2610.0734239345034;2651.535981203289;2661.9600705989424;2676.4245687177254;2694.178275625934;4391.0559229765595;4491.258942274529;4572.31415287707;4605.240135377663;4605.401297831281;4595.632349412047;4619;4644.326572646964;4653.208954477738;4660.650451216164;4230.365445183216;4252.829886804524;4305.138972205564;4351.891202719926;4383.430154079981;4071.409645601386;4299.118680670455;4311.396404503372;4363.956360436387;4397.142557201347;4203.117345357478;4205.642520385741;4222.071144348239;4279.079997800457;4311;4285;4320.848770293056;4327.37253098299;4359.760213188273;4359.84740534083;4046.514418269797;4294.828206871722;4301.139772045603;4308.18144552534;4350.0647360817575;4451.2655411857;4461.888452788674;4470.709403888737;4545.340925565807;4572.405587273666;5007.399112106534;5026.29631851541;5026.874328141789;5027.044861476308;5071.594272458195;5022.748862556894;5023.422306434771;5031.22016087507;5032.471590482984;5049.520295571915;4394.824207031715;4503.842365517191;4507.729536227836;4580.358749775034;4684.180268453007;5049.116404629175;5056.292119103328;5066.290719299301;5066.569341605931;5067.290579318898;4846.733429661403;4858.076965376567;4859.2954021667365;4865.5864251538305;4889.877753056131;4718.811247550059;4774.3077253798;4795.256735206049;4888.071266459361;5010.223415370623;4928.162212423897;4949.604031677457;4952.702837829742;4957.454679985199;4965.478624744422;4949.084419382426;4950.851474455772;4950.876228094255;4951.8266860659705;4987.102321582078;3917.373220284741;3957.3470377387407;4001.5398229204015;4114.362273847559;4160.771157586361;3562;3589.3539162950397;3604.4052731299566;3612.187257866959;3628.63713628635;4210.494740631144;4316.525182229952;4318.201132790381;4350.934735978963;4355.107203023373;4699.154152252559;4817.205161148441;4818.8795280118275;5009.348784658044;5026.974865125724;4110.260153172458;4158.293090174617;4165.250254954138;4191.7275377100395;4202.684798640114;4343.1530851484285;4350.695451318377;4352.086061926968;4353.281708518122;4393.340998850134;4539.319102134707;4658.440987081572;4659.2312268475325;4688.64835137366;4727.030958653537;4846.757662116951;4886.3647725796845;4906.705597664151;4908.754562271801;4935.925961110514;4740.146773580788;4768.189407800613;4770.403699537558;4775.641826863069;4778.450478195052;4707.199776038014;4834.419869615669;4838.491958344323;4958.677685950402;4993.4756850530175;4898.583620392164;4943.110240156662;4958.1323268428605;4959.181735013826;4994.750262486934;4756.9762151189025;4889.266610008385;4889.90220195587;4892.877678058077;4925.236588328815;4630.259158534618;4762.071396077731;4763.809447622057;4861.635377346784;4932.1122198004705;4589.311603259538;4640.74475903815;4708.317293992283;4726.527347265246;4734.952650473589;4817.614590832795;4890.828820991248;4901.877453063702;4902.754862256802;4904.5095490452095;4799.784009719641;4800.207965685623;4802.567768900815;4803.447603525639;4815.9886423849985 14:21:29 INFO - 2015-12-05 14:21:29,935 DEBUG : BROWSER_OUTPUT: |1;ext.html;552.7628512547909;581.0847914534609;587.3891153200669;591.6272748168653;594.9464548190667;28267.717322826764;29073.127806165798;29079.12762617125;29143;29150.854245728795;29772.213667179985;30085;30292;37829.621703782956;38521.61478385215;7827.295543401078;7933.761987140395;7952.284294413502;7960.48256863305;7961.203879612021;7875.291223789858;7934.642941067666;7963.800904977393;7977.880331795028;7990.12108668046;7174.139103307611;7376.74181403651;10332.535035923402;10602.52288647009;10627.256092073558;10006.849897251546;10098.646547370807;10103.797924041515;10110.140638045776;10111.3427627204;7203.387712044482;7389.261073892621;9994.850077248848;10154.492275386201;10167.4916254187;37570.624293756984;38460.42309365362;38491.80754096239;38560.61439385598;38591.22817543661;2610.4779044191237;2684.8657567121763;2726.82275652082;2742.3966727320158;2870.2250392393935;27080;27919.162425127277;27930.581041284397;28026.439471210666;28420.857895710596;3391.9321613567836;3408.5739282589675;3445.3453843769603;3520.4015317396106;3587.766795158306;220856;221604;221987;222612;223249.88375058182;54073.72963135238;54448;54469.72765136149;54475;54508.72745636326;58771;58917.70541147267;59023.704881475314;59070.40929590649;59087;12910.28993405353;13268.800967985488;13270.1374410663;13273.867261327263;13299.601011969657;10452.68641940743;10496.212784041227;10502.842457363146;10505;10513.684589462327;17891.25099790063;18427.328037434498;18642.720359194624;18646.254149833854;18677;7503.5497870127965;7846.411519135973;7924.762257132295;7933.365330773524;7948.324392426593;860.7718954477068;874.7550685807984;910.0080911806031;966.9315406475883;995.4276291132628;24064.639030414557;25549.23352299434;25604.615930761054;25851.22446326613;25885.74114258871;872.5942436766807;931.7344556801279;979.1921664626711;997.9550920208608;1053.9565829828414;12929;13357.93321033408;13359.53241636538;13452.771494624643;13959;265446;269847;270184;270607;271008;45648.54351456509;45929;45942.85142871455;46049.76975115103;46149;1209.12338554549;1244.6514975806788;1254.021862946903;1254.8055051467038;1256.3215863433643;25533.616995744705;26294.868525658014;26479.205623831316;26755.19734407971;26778.732212678402;47028.7648561755;48144.51855481401;48154.27768583404;48155;48248.276275856595;226665;227056;227593;227672;227836;24902.750972490045;25216.369590759645;28377.574336384558;30758;31153.844230779607;37332.440013400366;37523.249535009694;38214.80892595519;38710.419343709305;38737.418938715375;32020.65139781373;32173.356532868744;32328;33022.66977330292;33375.49936750902;25315.74684253134;29814.85092574523;32926.17684557809;33219.50170747392;33810.661893380755;30638.387232254783;30757.53863692091;30853.8457307712;30857.69142308638;31007.68992310048;27093.27828667256;27515;27767.444651107267;28008.159755207376;28013.439731205668;22982.655260170777;23483.295501134995;23815.761842381355;23826.046958122173;23924.52150957006 14:21:29 INFO - 2015-12-05 14:21:29,936 DEBUG : BROWSER_OUTPUT: |2;jquery.html;315.00615557914784;330.9238875058735;331.6452292385605;331.6749585406302;335.15373681454327;12463.813042804366;12777.616671499869;15111.471098511554;15470.535883923472;15523.223838808057;12662.11365204436;15036.774448383283;16038.518844434657;16387.672246555063;16535.255913483892;4990.700557966534;5021.397432308119;5051.242313652963;5058.747062646871;5060.2409638554145;3558.804265765382;3648.2885837261742;5054.140796064659;5094.745262736867;5585.972070139644;5796.101604251347;5811.0702287633985;5832.096025116092;5835.620684655505;5837.766489340443;5691.373948865621;6014.308354539218;6016.96991515044;6021.066734656091;6021.096835474692;5194.844154675328;5219.19102539107;5239.607029472805;5257.369115706101;5259.921101183485;19775.11012004449;19814.900925495425;19883.80116198834;20151.79848201514;20831.479213019644;1788.0791392432907;1870.8783929044705;1905.3521802587047;1965.1746266567932;1975.0867470481069;12428.440720167615;12544.623661290176;12653;12864.09951303409;12927.030472714585;1657.991710041442;1673.9246733897003;1925.1914196037699;1959.9118039688249;2021.9090140943545;60935.695321523555;64324.356756432775;65098;65850.34149658537;66466.66766666136;15732.213389330716;15738;15739.527814165593;15755;15883.52349429519;23361.182358617367;23373.649395259086;23627.7637223629;23629.7637023631;23653.881730591238;8940.776480588038;8948.120894612075;8956.910430895608;9011.459312441275;9037.051109633525;7594.886076708854;7600.391968642495;7602.049743782028;7610.543367397974;7650.655720492591;7700.422468314899;7717.2668596483245;7725.304722574995;7733.806654833562;7734.265244801735;1715.613986852973;1724.7326664367042;1742.8954262744276;2193.4954960359205;3045.1625802904377;800.8638531449668;810.1776696652902;867.6312567158932;901.2429559170197;946.1579194516886;16029;16052.117133557766;16115.19424028794;16172.919135404247;16457.506274811774;827.5986146718836;844.6536919862826;857.9571021448903;860.2988564320059;861.586438509519;8978.281737460988;9168.724938251864;9473.715788526355;9497.857532137023;9521.761955951157;300204;304437;321047;322851;486050;69987.30012699807;76223.23776762272;77883.22116778872;78041;78506.6074669623;1027.075631931253;1047.1308813684775;1058.2747336907448;1063.7340664833791;1064.7018834726289;13797.655058623615;14453.132812030892;14659.853401465849;14697.485588004369;15459.61350966235;33670.831645841616;34208;34420.82789586036;35339.11652208612;35546.644533555365;42261.57738422576;43383.56616433795;43911.34132987944;44791;46971.76514117407;8903.777405564913;8920.643174272956;9039.954800225956;9050.683226087056;9133.680321188727;16633.916830415772;17067;17072.57318567046;17237.741433878753;17405.912970435067;13816.447342106605;13999.930000349934;14007.789883151558;14071.507497237548;14131;13372.264525451194;13474.326283685581;13518.79721804154;13673.111247768864;13990.300484975507;13803;14044.438222470986;14094.859051409354;14128.717425651635;14373.568792936228;8782.956085219534;8947.150020748019;8950.104989501258;9023.278137749096;9062.139096785795;10591.682249532527;14203.573892783234;14311.427542898167;14330.856691432953;14603.561893143222 14:21:29 INFO - 2015-12-05 14:21:29,936 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1435.0958895895585;1465.8900582456317;1487.3084015932593;1583.9683206335874;1735.9045252511107;5895.4104589541075;7034.824129396761;7201.279872012796;7203.351698347148;7208.819779505515;7132.251113633071;7260;7268.96365518173;7276.126864776221;7276.708931642728;1994.42161773086;2017.7074324222979;2021.858469907107;2023.5548179400507;2024.4230394337617;2097.192580856366;2130.7656157822626;2137.1130980643015;2137.1558234497365;2138.2943628602525;2038.9796102039013;2045.0490521907311;2063.350044735911;2066.214838361428;2074.636938535758;2068.4932191613075;2093.8324934005245;2103.7265155529685;2105.9999999999923;2110.7256056712604;2063.8039386258283;2073.1603700501323;2101.7898210179014;2102.0225595098354;2105.3683894831643;7171.462140339496;7251.093613298338;7270.927290727078;7276.745313913988;7276.762950298462;4041.232165888501;4138.110306284163;4138.979305103455;4143.212789569972;4148.419221309019;2613.2552222616655;2636.8154229203965;2667.906623268176;2667.9733202667917;2670.572708366652;853.4921721575653;855.7304449098576;868.3096937934357;883.465503370458;885.7608445719619;9749.805003899954;9787;9789.412635241908;9794.706158815317;9803.068708472683;3851.2490064437725;3853.865114720971;3916.804159792056;3953.92092158161;3962.5244970603712;8365.539895305696;8406.621702023423;8412.116727743622;8417.537035462985;8422.410431269753;4256.6807489438415;4282.272013757606;4301.763403012865;4303.332983387518;4303.462067241595;3162.4623813951684;3234.951475727866;3786.1670432504807;3898.4542164097047;3899.200663863901;3476.3394954958476;3504.0889368764306;3523.1544429336773;3524.6299138590593;3559.2169722660974;1108.5731993182521;1112.449337577904;1131.886811318878;1138.3170097941334;1143.1197977557401;1156.4160099149876;1163.627639155479;1165.5454372794618;1177.4877928101303;1178.2753606531921;6597.60414375139;6620.668966551653;6632.369924857131;6668.133142691419;6710.127683401127;419.5291298926741;428.0070237050076;431.5102358822759;432.15729327810897;432.47022397563364;5433.1035379161995;5438.238646589481;5446.101393270066;5453.972730136404;5459.563234941195;7837.843243135106;7992.640331185111;8572.228499435081;8704.955405351398;8745.693900713444;7892.802679933047;7934.087579928267;7997.800054998555;8002.679892804223;8024.478408903403;6767.424768894699;6812.386885180357;6861.519693621499;6868.381845633917;6877.6217308048535;6775.119234499483;6846.657667116525;6855.211650660238;6857.314268573103;6859.725610975505;7557.4331925106935;7813.296803287504;7815.140334563307;7879.054513458422;7939.682412703427;7662.501937374052;7896.802579935547;7916.525008499509;7980.441369104107;8031.718889839061;5449.536789372948;5551.417101204315;6328.873422531616;6397.392247736458;6471.094046833353;7037.401820845081;7069.9646501767165;7093;7107.538010029331;7124.3944264738075;6366.681665916778;6502.512311576556;6519.608823470607;6595.142631457879;6598.04328372393;6422.582532135396;6430.356964303533;6588.143541339787;6643.970184621391;6661.467082633475;6211.751529938932;6289.496840252677;6291.370862913672;6296.905546416716;6299.590526615755;5777.277840269966;5799.101139323411;5815.94184058154;5894.646321220741;5896.439838215363;5579.358373787067;5604.943950560442;5617.4101719320515;5617.634853734494;5621.831345059655 14:21:29 INFO - 2015-12-05 14:21:29,937 DEBUG : BROWSER_OUTPUT: |4;prototype.html;278.6558600128841;281.2504675041016;284.7679141499677;285.8813592359172;289.37783764905436;5209.739513024352;5296.920546191805;5300.204969254609;5339.385970613381;5352.090144675405;5239.318888544484;5303.7082960437165;5310.0441920454305;5313.707746073965;5314.707691076989;4004.1991601679633;4011.1576568920414;4014.799260037001;4016.839326426954;4017.8191981360837;3820.7134464915102;3941.3496773032416;3988.9202215955665;4008.7394319369146;4058.6753059755147;4029.476168098158;4029.6171863672903;4047.8583249586272;4048.251073551388;4062.2890994076065;3821.426785982125;4027.939580906289;4038.232735780222;4039.919201615966;4043.5147782266167;3409.7442691798215;3437.106352348407;3516.472529120627;3518.085297822559;3545.9113522161892;5092.261622064817;5098.745062746848;5104.64267501275;5110.488951104897;5114.207297868837;4598.103369842882;4635.443746750378;4636;4638.1187574360765;4638.281066434708;5390.73046347685;5498.202760599731;5506.339239291271;5507.118860982264;5512.090505066659;3819.3316169670475;3827.4067519534237;3827.827747751358;3829.3872980323295;3832.827522761482;5700.344460387026;5790.073588225863;5794.420557944214;5797.449242321973;5801.88396232073;3952.8418863245147;3963.147923196469;3964.682825373963;3964.742291751027;3964.980175099106;4004.8598299059395;4028.5971402860064;4033.616806403387;4036.3138266494766;4037.596240375939;4489.977550112294;4609.838655647036;4610.2623580227;4616.28447590624;4621.329907163443;5536.944630553643;5540.695261760642;5541.695206763586;5542.418046105182;5544.362398324163;1390.9026368154334;1400.8949328800381;1402.593247958101;1404.3539971612968;1405.845357010728;948.127722495306;948.4451595816524;951.5955718819613;972.2999440402899;975.4488713876636;4829.1790395632825;4835.492273311322;4845.224764037807;4848.345473361122;4850.6362022848425;5722.971385143131;5725.713714314267;5730.541556675456;5732.05421105513;5733.426657334233;4802.51974802517;4811.158047341702;4846.055019271279;4849.175640141185;4855.101806165871;3009.7441717453826;3062.0354588304613;3086.0279012111114;3086.6141732283463;3087.7838551301193;5250.081235783722;5328.120860058047;5377.919331210035;5473.917891231635;5478.58910581708;5902.527797776168;5929.762809487572;5930.347661757203;5933.614315069507;5943.821685349447;5449.427810079885;5454.53636440899;5454.536364409069;5467.425920278393;5469.07025805606;5629.6903670298525;5779.624324418899;5782.681952492653;5787.884242315215;5789.363170051207;5655;5657.519110875622;5662.122371032497;5667.093265077568;5667.971660141673;5460.91808622863;5462.863428414322;5463.289772329572;5471.945280547144;5479.6164268500825;3967.5238971323624;3974.28462876685;3974.6224108709625;3977.125032492847;3979.880603581897;5626.35296940857;5769;5780.913286300793;5782.508486778503;5784.4504772046585;5560.694161821139;5567.55459563242;5569.693666848362;5582.7766889323975;5583.190437386637;5555.0834112371;5556.305461817273;5560.555155587463;5560.888782224414;5572.442755724395;5297.099493086108;5450.046241907571;5452.754626041917;5476.753546090516;5477.917831232615;5622.522085622768;5624.971875140598;5626.07169816992;5627.634203776742;5632.464915832989;5460.31746031746;5463;5463.644863083887;5471.015217260931;5471.06991811401 14:21:29 INFO - 2015-12-05 14:21:29,938 DEBUG : BROWSER_OUTPUT: |5;yui.html;781.0354212547503;781.6326326626486;787.2167193642326;797.9601019949005;815.1359558867597;10890;11105.777884442326;11110.277831940919;11136.554537818487;11139.498722557484;11747.53009879606;11834.7633047339;11875.16873818833;11879.406029698524;11880.881191188108;625.5996162456021;638.7891995641427;796.8764841449556;810.8094597769519;814.1451475950258;803.0122948772984;808.4744915804715;810.5987536169604;812.959352032399;815.2255357410484;838.6393850644251;845.3617518773349;845.4504572028169;847.3729440214258;851.3997631669689;650.7429565321695;655.0370954696589;835.07723965019;847.8812966184739;849.2569002123142;630.1398590923402;630.7319389259546;633.2306247908767;633.5533448918501;634.3054355480788;12277.079219058607;12297.877021229851;12305.323207223599;12329.075319351085;12351.876481235162;11362.829557556643;11646.708832279177;11706.414679266003;11985.880141198564;12177.025837933033;9226.58480368385;9409.309454743332;9525.19035881951;9658.855117173178;9661.178799802025;3277.147941535218;3285.65500622436;3286.901392958215;3311.4701647736247;3364.764466487347;38778.418323725164;38857.417138742945;39142;39244.80377598122;39313.21373572541;9467.621295148254;9554.761130971781;9585.376950498196;9702;9779.951100244452;16048.358065677243;16118.75821862673;16162.515124546282;16163.191840407933;16184;5921.2302400688495;6065.787697430569;6094.542909281821;6205.131281620576;6286.811395658046;3580.445031020196;3637.8181090945345;3674.338619048597;3680.5215322007966;3680.8895733128047;2655.946881062368;2716.2937636214333;2720.374313907773;2722.3602453423428;2726.700062993069;468.292877754593;472.9243321068681;474.240567494592;485.81296200962885;488.101892517769;465.26456317934293;514.7477735909378;533.1789044870933;551.4650788734921;595.1162523652373;7512.173660897297;7654.655540500691;7674.270944260286;7702.114256860533;7755.650995705207;443.71380459603375;529.3145376737135;591.9437653422918;593.8693487432757;605.5972778102513;3507.5790905091553;3725.4784330193793;4050.3924411338535;4148;4288.849890253889;49901;50018.74990625097;50275;50343;50539.74730126326;40676.59323406787;41557.168856622695;41561;41565.1686966259;41649;38445.2310953785;38840;39244.60755392467;39293.803530982164;39574.60425395709;7906.683732650629;7938.982681732788;8068.677252909818;8308.086110527716;8395.943365816356;30667.693323066484;30867.228319292197;31135.688643114187;31315.217119572193;31617.5257371135;40293.39559906545;41008.79495602503;41507.37738933979;41759.791201045016;41762.164756704085;10020.749481263027;10134.493275336055;10193.133583645176;10208.693739187836;10253;10778.407187604756;11052;11256.437178141225;11516.769664606494;11703.063754899758;10166.135878450414;10175.08424241792;10180.440075795903;10262.230332724926;10949.288296260718;10605.41670208146;10978.176636752436;11053.944730276296;11065.668029959113;11385.658430247106;8401.579921004048;9860.457674827954;10338.224633152393;11063.889361106609;11150.553977840795;9030.179889984533;9064.546772661208;9269.397489163182;9430.811383772423;9561.187299079656;8974.102589740975;9049;9150.450972941644;9204;9235.722928312161 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,948 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: __startTimestamp1449354089930__endTimestamp 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:21:29 INFO - 2015-12-05 14:21:29,939 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4561.40 Median:4699.15 stddev:481.65 (10.2%) stddev-sans-first:458.15 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: Values: 2610.1 2651.5 2662.0 2676.4 2694.2 4391.1 4491.3 4572.3 4605.2 4605.4 4595.6 4619.0 4644.3 4653.2 4660.7 4230.4 4252.8 4305.1 4351.9 4383.4 4071.4 4299.1 4311.4 4364.0 4397.1 4203.1 4205.6 4222.1 4279.1 4311.0 4285.0 4320.8 4327.4 4359.8 4359.8 4046.5 4294.8 4301.1 4308.2 4350.1 4451.3 4461.9 4470.7 4545.3 4572.4 5007.4 5026.3 5026.9 5027.0 5071.6 5022.7 5023.4 5031.2 5032.5 5049.5 4394.8 4503.8 4507.7 4580.4 4684.2 5049.1 5056.3 5066.3 5066.6 5067.3 4846.7 4858.1 4859.3 4865.6 4889.9 4718.8 4774.3 4795.3 4888.1 5010.2 4928.2 4949.6 4952.7 4957.5 4965.5 4949.1 4950.9 4950.9 4951.8 4987.1 3917.4 3957.3 4001.5 4114.4 4160.8 3562.0 3589.4 3604.4 3612.2 3628.6 4210.5 4316.5 4318.2 4350.9 4355.1 4699.2 4817.2 4818.9 5009.3 5027.0 4110.3 4158.3 4165.3 4191.7 4202.7 4343.2 4350.7 4352.1 4353.3 4393.3 4539.3 4658.4 4659.2 4688.6 4727.0 4846.8 4886.4 4906.7 4908.8 4935.9 4740.1 4768.2 4770.4 4775.6 4778.5 4707.2 4834.4 4838.5 4958.7 4993.5 4898.6 4943.1 4958.1 4959.2 4994.8 4757.0 4889.3 4889.9 4892.9 4925.2 4630.3 4762.1 4763.8 4861.6 4932.1 4589.3 4640.7 4708.3 4726.5 4735.0 4817.6 4890.8 4901.9 4902.8 4904.5 4799.8 4800.2 4802.6 4803.4 4816.0 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39880.23 Median:29793.53 stddev:62664.74 (210.3%) stddev-sans-first:62770.96 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: Values: 552.8 581.1 587.4 591.6 594.9 28267.7 29073.1 29079.1 29143.0 29150.9 29772.2 30085.0 30292.0 37829.6 38521.6 7827.3 7933.8 7952.3 7960.5 7961.2 7875.3 7934.6 7963.8 7977.9 7990.1 7174.1 7376.7 10332.5 10602.5 10627.3 10006.8 10098.6 10103.8 10110.1 10111.3 7203.4 7389.3 9994.9 10154.5 10167.5 37570.6 38460.4 38491.8 38560.6 38591.2 2610.5 2684.9 2726.8 2742.4 2870.2 27080.0 27919.2 27930.6 28026.4 28420.9 3391.9 3408.6 3445.3 3520.4 3587.8 220856.0 221604.0 221987.0 222612.0 223249.9 54073.7 54448.0 54469.7 54475.0 54508.7 58771.0 58917.7 59023.7 59070.4 59087.0 12910.3 13268.8 13270.1 13273.9 13299.6 10452.7 10496.2 10502.8 10505.0 10513.7 17891.3 18427.3 18642.7 18646.3 18677.0 7503.5 7846.4 7924.8 7933.4 7948.3 860.8 874.8 910.0 966.9 995.4 24064.6 25549.2 25604.6 25851.2 25885.7 872.6 931.7 979.2 998.0 1054.0 12929.0 13357.9 13359.5 13452.8 13959.0 265446.0 269847.0 270184.0 270607.0 271008.0 45648.5 45929.0 45942.9 46049.8 46149.0 1209.1 1244.7 1254.0 1254.8 1256.3 25533.6 26294.9 26479.2 26755.2 26778.7 47028.8 48144.5 48154.3 48155.0 48248.3 226665.0 227056.0 227593.0 227672.0 227836.0 24902.8 25216.4 28377.6 30758.0 31153.8 37332.4 37523.2 38214.8 38710.4 38737.4 32020.7 32173.4 32328.0 33022.7 33375.5 25315.7 29814.9 32926.2 33219.5 33810.7 30638.4 30757.5 30853.8 30857.7 31007.7 27093.3 27515.0 27767.4 28008.2 28013.4 22982.7 23483.3 23815.8 23826.0 23924.5 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,940 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23847.10 Median:331.28 stddev:58348.52 (17612.8%) stddev-sans-first:58485.45 14:21:29 INFO - 2015-12-05 14:21:29,941 DEBUG : BROWSER_OUTPUT: Values: 315.0 330.9 331.6 331.7 335.2 12463.8 12777.6 15111.5 15470.5 15523.2 12662.1 15036.8 16038.5 16387.7 16535.3 4990.7 5021.4 5051.2 5058.7 5060.2 3558.8 3648.3 5054.1 5094.7 5586.0 5796.1 5811.1 5832.1 5835.6 5837.8 5691.4 6014.3 6017.0 6021.1 6021.1 5194.8 5219.2 5239.6 5257.4 5259.9 19775.1 19814.9 19883.8 20151.8 20831.5 1788.1 1870.9 1905.4 1965.2 1975.1 12428.4 12544.6 12653.0 12864.1 12927.0 1658.0 1673.9 1925.2 1959.9 2021.9 60935.7 64324.4 65098.0 65850.3 66466.7 15732.2 15738.0 15739.5 15755.0 15883.5 23361.2 23373.6 23627.8 23629.8 23653.9 8940.8 8948.1 8956.9 9011.5 9037.1 7594.9 7600.4 7602.0 7610.5 7650.7 7700.4 7717.3 7725.3 7733.8 7734.3 1715.6 1724.7 1742.9 2193.5 3045.2 800.9 810.2 867.6 901.2 946.2 16029.0 16052.1 16115.2 16172.9 16457.5 827.6 844.7 858.0 860.3 861.6 8978.3 9168.7 9473.7 9497.9 9521.8 300204.0 304437.0 321047.0 322851.0 486050.0 69987.3 76223.2 77883.2 78041.0 78506.6 1027.1 1047.1 1058.3 1063.7 1064.7 13797.7 14453.1 14659.9 14697.5 15459.6 33670.8 34208.0 34420.8 35339.1 35546.6 42261.6 43383.6 43911.3 44791.0 46971.8 8903.8 8920.6 9040.0 9050.7 9133.7 16633.9 17067.0 17072.6 17237.7 17405.9 13816.4 13999.9 14007.8 14071.5 14131.0 13372.3 13474.3 13518.8 13673.1 13990.3 13803.0 14044.4 14094.9 14128.7 14373.6 8783.0 8947.2 8950.1 9023.3 9062.1 10591.7 14203.6 14311.4 14330.9 14603.6 14:21:29 INFO - 2015-12-05 14:21:29,941 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,942 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4970.00 Median:5895.03 stddev:2601.99 (44.1%) stddev-sans-first:2595.72 14:21:29 INFO - 2015-12-05 14:21:29,942 DEBUG : BROWSER_OUTPUT: Values: 1435.1 1465.9 1487.3 1584.0 1735.9 5895.4 7034.8 7201.3 7203.4 7208.8 7132.3 7260.0 7269.0 7276.1 7276.7 1994.4 2017.7 2021.9 2023.6 2024.4 2097.2 2130.8 2137.1 2137.2 2138.3 2039.0 2045.0 2063.4 2066.2 2074.6 2068.5 2093.8 2103.7 2106.0 2110.7 2063.8 2073.2 2101.8 2102.0 2105.4 7171.5 7251.1 7270.9 7276.7 7276.8 4041.2 4138.1 4139.0 4143.2 4148.4 2613.3 2636.8 2667.9 2668.0 2670.6 853.5 855.7 868.3 883.5 885.8 9749.8 9787.0 9789.4 9794.7 9803.1 3851.2 3853.9 3916.8 3953.9 3962.5 8365.5 8406.6 8412.1 8417.5 8422.4 4256.7 4282.3 4301.8 4303.3 4303.5 3162.5 3235.0 3786.2 3898.5 3899.2 3476.3 3504.1 3523.2 3524.6 3559.2 1108.6 1112.4 1131.9 1138.3 1143.1 1156.4 1163.6 1165.5 1177.5 1178.3 6597.6 6620.7 6632.4 6668.1 6710.1 419.5 428.0 431.5 432.2 432.5 5433.1 5438.2 5446.1 5454.0 5459.6 7837.8 7992.6 8572.2 8705.0 8745.7 7892.8 7934.1 7997.8 8002.7 8024.5 6767.4 6812.4 6861.5 6868.4 6877.6 6775.1 6846.7 6855.2 6857.3 6859.7 7557.4 7813.3 7815.1 7879.1 7939.7 7662.5 7896.8 7916.5 7980.4 8031.7 5449.5 5551.4 6328.9 6397.4 6471.1 7037.4 7070.0 7093.0 7107.5 7124.4 6366.7 6502.5 6519.6 6595.1 6598.0 6422.6 6430.4 6588.1 6644.0 6661.5 6211.8 6289.5 6291.4 6296.9 6299.6 5777.3 5799.1 5815.9 5894.6 5896.4 5579.4 5604.9 5617.4 5617.6 5621.8 14:21:29 INFO - 2015-12-05 14:21:29,942 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,943 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4588.45 Median:5301.96 stddev:1363.72 (25.7%) stddev-sans-first:1328.63 14:21:29 INFO - 2015-12-05 14:21:29,943 DEBUG : BROWSER_OUTPUT: Values: 278.7 281.3 284.8 285.9 289.4 5209.7 5296.9 5300.2 5339.4 5352.1 5239.3 5303.7 5310.0 5313.7 5314.7 4004.2 4011.2 4014.8 4016.8 4017.8 3820.7 3941.3 3988.9 4008.7 4058.7 4029.5 4029.6 4047.9 4048.3 4062.3 3821.4 4027.9 4038.2 4039.9 4043.5 3409.7 3437.1 3516.5 3518.1 3545.9 5092.3 5098.7 5104.6 5110.5 5114.2 4598.1 4635.4 4636.0 4638.1 4638.3 5390.7 5498.2 5506.3 5507.1 5512.1 3819.3 3827.4 3827.8 3829.4 3832.8 5700.3 5790.1 5794.4 5797.4 5801.9 3952.8 3963.1 3964.7 3964.7 3965.0 4004.9 4028.6 4033.6 4036.3 4037.6 4490.0 4609.8 4610.3 4616.3 4621.3 5536.9 5540.7 5541.7 5542.4 5544.4 1390.9 1400.9 1402.6 1404.4 1405.8 948.1 948.4 951.6 972.3 975.4 4829.2 4835.5 4845.2 4848.3 4850.6 5723.0 5725.7 5730.5 5732.1 5733.4 4802.5 4811.2 4846.1 4849.2 4855.1 3009.7 3062.0 3086.0 3086.6 3087.8 5250.1 5328.1 5377.9 5473.9 5478.6 5902.5 5929.8 5930.3 5933.6 5943.8 5449.4 5454.5 5454.5 5467.4 5469.1 5629.7 5779.6 5782.7 5787.9 5789.4 5655.0 5657.5 5662.1 5667.1 5668.0 5460.9 5462.9 5463.3 5471.9 5479.6 3967.5 3974.3 3974.6 3977.1 3979.9 5626.4 5769.0 5780.9 5782.5 5784.5 5560.7 5567.6 5569.7 5582.8 5583.2 5555.1 5556.3 5560.6 5560.9 5572.4 5297.1 5450.0 5452.8 5476.8 5477.9 5622.5 5625.0 5626.1 5627.6 5632.5 5460.3 5463.0 5463.6 5471.0 5471.1 14:21:29 INFO - 2015-12-05 14:21:29,943 DEBUG : BROWSER_OUTPUT: 14:21:29 INFO - 2015-12-05 14:21:29,943 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12150.22 Median:41760.98 stddev:13566.71 (32.5%) stddev-sans-first:13577.90 14:21:29 INFO - 2015-12-05 14:21:29,944 DEBUG : BROWSER_OUTPUT: Values: 781.0 781.6 787.2 798.0 815.1 10890.0 11105.8 11110.3 11136.6 11139.5 11747.5 11834.8 11875.2 11879.4 11880.9 625.6 638.8 796.9 810.8 814.1 803.0 808.5 810.6 813.0 815.2 838.6 845.4 845.5 847.4 851.4 650.7 655.0 835.1 847.9 849.3 630.1 630.7 633.2 633.6 634.3 12277.1 12297.9 12305.3 12329.1 12351.9 11362.8 11646.7 11706.4 11985.9 12177.0 9226.6 9409.3 9525.2 9658.9 9661.2 3277.1 3285.7 3286.9 3311.5 3364.8 38778.4 38857.4 39142.0 39244.8 39313.2 9467.6 9554.8 9585.4 9702.0 9780.0 16048.4 16118.8 16162.5 16163.2 16184.0 5921.2 6065.8 6094.5 6205.1 6286.8 3580.4 3637.8 3674.3 3680.5 3680.9 2655.9 2716.3 2720.4 2722.4 2726.7 468.3 472.9 474.2 485.8 488.1 465.3 514.7 533.2 551.5 595.1 7512.2 7654.7 7674.3 7702.1 7755.7 443.7 529.3 591.9 593.9 605.6 3507.6 3725.5 4050.4 4148.0 4288.8 49901.0 50018.7 50275.0 50343.0 50539.7 40676.6 41557.2 41561.0 41565.2 41649.0 38445.2 38840.0 39244.6 39293.8 39574.6 7906.7 7939.0 8068.7 8308.1 8395.9 30667.7 30867.2 31135.7 31315.2 31617.5 40293.4 41008.8 41507.4 41759.8 41762.2 10020.7 10134.5 10193.1 10208.7 10253.0 10778.4 11052.0 11256.4 11516.8 11703.1 10166.1 10175.1 10180.4 10262.2 10949.3 10605.4 10978.2 11053.9 11065.7 11385.7 8401.6 9860.5 10338.2 11063.9 11150.6 9030.2 9064.5 9269.4 9430.8 9561.2 8974.1 9049.0 9150.5 9204.0 9235.7 14:21:29 INFO - 2015-12-05 14:21:29,944 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:21:29 INFO - 2015-12-05 14:21:29,944 DEBUG : BROWSER_OUTPUT: 14:21:30 INFO - 2015-12-05 14:21:30,673 INFO : Browser exited with error code: 0 14:21:30 INFO - 2015-12-05 14:21:30,697 INFO : Completed test dromaeo_css (00:18:37) 14:21:30 INFO - 2015-12-05 14:21:30,697 INFO : Starting test kraken 14:21:30 INFO - 2015-12-05 14:21:30,697 DEBUG : operating with platform_type : linux_ 14:21:30 INFO - 2015-12-05 14:21:30,697 INFO : Initialising browser for kraken test... 14:21:30 INFO - 2015-12-05 14:21:30,703 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4K7lr/profile http://localhost:58240/getInfo.html 14:21:35 INFO - 2015-12-05 14:21:35,084 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:21:35 INFO - 2015-12-05 14:21:35,084 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:21:35 INFO - 2015-12-05 14:21:35,084 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:21:35 INFO - 2015-12-05 14:21:35,084 DEBUG : BROWSER_OUTPUT: __metrics 14:21:35 INFO - 2015-12-05 14:21:35,173 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] 14:21:35 INFO - 2015-12-05 14:21:35,233 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:35 ERROR - 2015-12-05 14:21:35,249 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 14:21:36 INFO - 2015-12-05 14:21:36,072 INFO : Browser initialized. 14:21:36 INFO - 2015-12-05 14:21:36,073 INFO : Running cycle 1/1 for kraken test... 14:21:36 INFO - 2015-12-05 14:21:36,073 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb4K7lr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:21:48 INFO - 2015-12-05 14:21:48,114 DEBUG : BROWSER_OUTPUT: RSS: Main: 142700544 14:21:48 INFO - 2015-12-05 14:21:48,114 DEBUG : BROWSER_OUTPUT: 14:21:50 INFO - 2015-12-05 14:21:50,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:51 INFO - 2015-12-05 14:21:51,342 DEBUG : BROWSER_OUTPUT: RSS: Main: 176201728 14:21:51 INFO - 2015-12-05 14:21:51,343 DEBUG : BROWSER_OUTPUT: 14:21:54 INFO - 2015-12-05 14:21:54,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-dft) 14:21:54 INFO - 2015-12-05 14:21:54,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 165888000 14:21:54 INFO - 2015-12-05 14:21:54,598 DEBUG : BROWSER_OUTPUT: 14:21:57 INFO - 2015-12-05 14:21:57,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-fft) 14:21:58 INFO - 2015-12-05 14:21:58,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 154390528 14:21:58 INFO - 2015-12-05 14:21:58,164 DEBUG : BROWSER_OUTPUT: 14:22:00 INFO - 2015-12-05 14:22:00,204 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58240/tests/kraken/driver.html?testName=audio-oscillator) 14:22:00 INFO - 2015-12-05 14:22:00,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 155791360 14:22:00 INFO - 2015-12-05 14:22:00,786 DEBUG : BROWSER_OUTPUT: 14:22:03 INFO - 2015-12-05 14:22:03,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:03 INFO - 2015-12-05 14:22:03,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 157040640 14:22:03 INFO - 2015-12-05 14:22:03,604 DEBUG : BROWSER_OUTPUT: 14:22:06 INFO - 2015-12-05 14:22:06,627 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:07 INFO - 2015-12-05 14:22:07,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 157364224 14:22:07 INFO - 2015-12-05 14:22:07,213 DEBUG : BROWSER_OUTPUT: 14:22:10 INFO - 2015-12-05 14:22:10,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58240/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:11 INFO - 2015-12-05 14:22:11,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 157626368 14:22:11 INFO - 2015-12-05 14:22:11,177 DEBUG : BROWSER_OUTPUT: 14:22:14 INFO - 2015-12-05 14:22:14,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58240/tests/kraken/driver.html?testName=json-parse-financial) 14:22:14 INFO - 2015-12-05 14:22:14,617 DEBUG : BROWSER_OUTPUT: RSS: Main: 157564928 14:22:14 INFO - 2015-12-05 14:22:14,618 DEBUG : BROWSER_OUTPUT: 14:22:16 INFO - 2015-12-05 14:22:16,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:16 INFO - 2015-12-05 14:22:16,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 168865792 14:22:16 INFO - 2015-12-05 14:22:16,960 DEBUG : BROWSER_OUTPUT: 14:22:18 INFO - 2015-12-05 14:22:18,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:19 INFO - 2015-12-05 14:22:19,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 168103936 14:22:19 INFO - 2015-12-05 14:22:19,431 DEBUG : BROWSER_OUTPUT: 14:22:21 INFO - 2015-12-05 14:22:21,576 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:22 INFO - 2015-12-05 14:22:22,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 178962432 14:22:22 INFO - 2015-12-05 14:22:22,157 DEBUG : BROWSER_OUTPUT: 14:22:24 INFO - 2015-12-05 14:22:24,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:25 INFO - 2015-12-05 14:22:25,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 184188928 14:22:25 INFO - 2015-12-05 14:22:25,253 DEBUG : BROWSER_OUTPUT: 14:22:27 INFO - 2015-12-05 14:22:27,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:28 INFO - 2015-12-05 14:22:28,450 DEBUG : BROWSER_OUTPUT: RSS: Main: 182935552 14:22:28 INFO - 2015-12-05 14:22:28,450 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58240/tests/kraken/driver.html?testName=ai-astar) 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: RSS: Main: 241381376 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:22:30 INFO - 2015-12-05 14:22:30,457 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;114;105;112;111;112;100;111;111;102 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;153;165;127;158;154;129;167;129 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;161;161;160;161;161;161;161 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;72;85;92;72;72;72;122;89;71 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;94;94;95;136;95;96;128 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;110;110;109;110;109 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;146;146;146;146;146;158;145;146 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 14:22:30 INFO - 2015-12-05 14:22:30,458 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;71;70;71;71;72;70;73;70;71 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;67;67;67;66;67;68 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;84;84;85;85;83;84;85;82 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;118;124;115;119;126;120;125;130;127 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;131;152;156;147;145;132;143;145;142;135 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;67;67;69;69;67;67;68;67;67 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:22:30 INFO - 2015-12-05 14:22:30,459 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:22:30 INFO - 2015-12-05 14:22:30,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,998 14:22:30 INFO - 2015-12-05 14:22:30,460 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:22:30 INFO - 2015-12-05 14:22:30,460 DEBUG : BROWSER_OUTPUT: __startTimestamp1449354150451__endTimestamp 14:22:30 INFO - 2015-12-05 14:22:30,460 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,461 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:22:30 INFO - 2015-12-05 14:22:30,461 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.70 Median:111.00 stddev:4.72 (4.2%) stddev-sans-first:5.00 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: Values: 109.0 114.0 105.0 112.0 111.0 112.0 100.0 111.0 111.0 102.0 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.00 Median:155.50 stddev:16.10 (10.4%) stddev-sans-first:16.67 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 153.0 165.0 127.0 158.0 154.0 129.0 167.0 129.0 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 161.0 161.0 160.0 161.0 161.0 161.0 161.0 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.20 Median:73.50 stddev:16.08 (21.9%) stddev-sans-first:16.84 14:22:30 INFO - 2015-12-05 14:22:30,462 DEBUG : BROWSER_OUTPUT: Values: 75.0 72.0 85.0 92.0 72.0 72.0 72.0 122.0 89.0 71.0 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:95.00 stddev:17.89 (18.8%) stddev-sans-first:18.54 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 94.0 94.0 95.0 136.0 95.0 96.0 128.0 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 110.0 110.0 109.0 110.0 109.0 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:146.00 stddev:3.83 (2.6%) stddev-sans-first:4.03 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 146.0 146.0 146.0 146.0 146.0 158.0 145.0 146.0 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 14:22:30 INFO - 2015-12-05 14:22:30,463 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:1.14 (1.6%) stddev-sans-first:1.00 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 70.0 71.0 71.0 72.0 70.0 73.0 70.0 71.0 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 67.0 67.0 67.0 66.0 67.0 68.0 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.00 stddev:1.16 (1.4%) stddev-sans-first:1.05 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 84.0 84.0 85.0 85.0 83.0 84.0 85.0 82.0 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.00 Median:124.50 stddev:5.08 (4.1%) stddev-sans-first:4.90 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: Values: 116.0 118.0 124.0 115.0 119.0 126.0 120.0 125.0 130.0 127.0 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,464 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:145.00 stddev:8.19 (5.6%) stddev-sans-first:7.49 14:22:30 INFO - 2015-12-05 14:22:30,465 DEBUG : BROWSER_OUTPUT: Values: 131.0 152.0 156.0 147.0 145.0 132.0 143.0 145.0 142.0 135.0 14:22:30 INFO - 2015-12-05 14:22:30,465 DEBUG : BROWSER_OUTPUT: 14:22:30 INFO - 2015-12-05 14:22:30,465 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:0.95 (1.4%) stddev-sans-first:0.88 14:22:30 INFO - 2015-12-05 14:22:30,465 DEBUG : BROWSER_OUTPUT: Values: 69.0 67.0 67.0 69.0 69.0 67.0 67.0 68.0 67.0 67.0 14:22:30 INFO - 2015-12-05 14:22:30,465 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:22:30 INFO - 2015-12-05 14:22:30,465 DEBUG : BROWSER_OUTPUT: 14:22:31 INFO - 2015-12-05 14:22:31,269 INFO : Browser exited with error code: 0 14:22:31 INFO - 2015-12-05 14:22:31,328 INFO : Completed test kraken (00:01:00) 14:22:31 INFO - 2015-12-05 14:22:31,328 INFO : Starting test v8_7 14:22:31 INFO - 2015-12-05 14:22:31,328 DEBUG : operating with platform_type : linux_ 14:22:31 INFO - 2015-12-05 14:22:31,328 INFO : Initialising browser for v8_7 test... 14:22:31 INFO - 2015-12-05 14:22:31,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRV_oD1/profile http://localhost:58240/getInfo.html 14:22:35 INFO - 2015-12-05 14:22:35,378 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:22:35 INFO - 2015-12-05 14:22:35,378 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:22:35 INFO - 2015-12-05 14:22:35,378 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:22:35 INFO - 2015-12-05 14:22:35,378 DEBUG : BROWSER_OUTPUT: __metrics 14:22:35 INFO - 2015-12-05 14:22:35,495 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] 14:22:35 INFO - 2015-12-05 14:22:35,551 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:22:36 INFO - 2015-12-05 14:22:36,754 INFO : Browser initialized. 14:22:36 INFO - 2015-12-05 14:22:36,755 INFO : Running cycle 1/1 for v8_7 test... 14:22:36 INFO - 2015-12-05 14:22:36,755 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRV_oD1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:22:48 INFO - 2015-12-05 14:22:48,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 142659584 14:22:48 INFO - 2015-12-05 14:22:48,757 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,159 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:58240/tests/v8_7/run.html (next: http://localhost:58240/tests/v8_7/run.html) 14:23:10 INFO - 2015-12-05 14:23:10,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 443518976 14:23:10 INFO - 2015-12-05 14:23:10,409 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,410 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:23:10 INFO - 2015-12-05 14:23:10,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:23:10 INFO - 2015-12-05 14:23:10,411 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:23:10 INFO - 2015-12-05 14:23:10,411 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:23:10 INFO - 2015-12-05 14:23:10,411 DEBUG : BROWSER_OUTPUT: |0;Richards;165.97510373443984 14:23:10 INFO - 2015-12-05 14:23:10,411 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.77457501847746 14:23:10 INFO - 2015-12-05 14:23:10,411 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.45229383619477 14:23:10 INFO - 2015-12-05 14:23:10,412 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 14:23:10 INFO - 2015-12-05 14:23:10,412 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1994.0239043824702 14:23:10 INFO - 2015-12-05 14:23:10,412 DEBUG : BROWSER_OUTPUT: |5;Earley;783.6990595611285 14:23:10 INFO - 2015-12-05 14:23:10,412 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 14:23:10 INFO - 2015-12-05 14:23:10,412 DEBUG : BROWSER_OUTPUT: |7;RegExp;28714.285714285714 14:23:10 INFO - 2015-12-05 14:23:10,412 DEBUG : BROWSER_OUTPUT: |8;Splay;603.864734299517 14:23:10 INFO - 2015-12-05 14:23:10,413 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 14:23:10 INFO - 2015-12-05 14:23:10,413 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:23:10 INFO - 2015-12-05 14:23:10,413 DEBUG : BROWSER_OUTPUT: __startTimestamp1449354190410__endTimestamp 14:23:10 INFO - 2015-12-05 14:23:10,413 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,414 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:23:10 INFO - 2015-12-05 14:23:10,414 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:23:10 INFO - 2015-12-05 14:23:10,414 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,414 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.98 Median:165.98 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,414 DEBUG : BROWSER_OUTPUT: Values: 166.0 14:23:10 INFO - 2015-12-05 14:23:10,414 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,415 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.77 Median:184.77 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,415 DEBUG : BROWSER_OUTPUT: Values: 184.8 14:23:10 INFO - 2015-12-05 14:23:10,415 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,415 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,415 DEBUG : BROWSER_OUTPUT: Values: 281.5 14:23:10 INFO - 2015-12-05 14:23:10,415 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,416 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,416 DEBUG : BROWSER_OUTPUT: Values: 5186.5 14:23:10 INFO - 2015-12-05 14:23:10,416 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,416 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,416 DEBUG : BROWSER_OUTPUT: Values: 1994.0 14:23:10 INFO - 2015-12-05 14:23:10,417 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,417 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.70 Median:783.70 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,417 DEBUG : BROWSER_OUTPUT: Values: 783.7 14:23:10 INFO - 2015-12-05 14:23:10,417 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,417 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,418 DEBUG : BROWSER_OUTPUT: Values: 12000.0 14:23:10 INFO - 2015-12-05 14:23:10,418 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,418 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:28714.29 Median:28714.29 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,418 DEBUG : BROWSER_OUTPUT: Values: 28714.3 14:23:10 INFO - 2015-12-05 14:23:10,418 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,418 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.86 Median:603.86 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,419 DEBUG : BROWSER_OUTPUT: Values: 603.9 14:23:10 INFO - 2015-12-05 14:23:10,419 DEBUG : BROWSER_OUTPUT: 14:23:10 INFO - 2015-12-05 14:23:10,419 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 14:23:10 INFO - 2015-12-05 14:23:10,419 DEBUG : BROWSER_OUTPUT: Values: 4826.9 14:23:10 INFO - 2015-12-05 14:23:10,420 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:23:10 INFO - 2015-12-05 14:23:10,420 DEBUG : BROWSER_OUTPUT: 14:23:11 INFO - 2015-12-05 14:23:11,317 INFO : Browser exited with error code: 0 14:23:11 INFO - 2015-12-05 14:23:11,336 INFO : Completed test v8_7 (00:00:40) 14:23:11 INFO - 2015-12-05 14:23:11,453 INFO : Completed test suite (00:20:18) 14:23:11 INFO - 2015-12-05 14:23:11,454 DEBUG : Working with test: dromaeo_css 14:23:11 INFO - 2015-12-05 14:23:11,454 DEBUG : Generating results file: dromaeo_css 14:23:11 INFO - 2015-12-05 14:23:11,455 DEBUG : Working with test: kraken 14:23:11 INFO - 2015-12-05 14:23:11,455 DEBUG : Generating results file: kraken 14:23:11 INFO - 2015-12-05 14:23:11,456 INFO : javascript benchmark 14:23:11 INFO - 2015-12-05 14:23:11,456 DEBUG : Working with test: v8_7 14:23:11 INFO - 2015-12-05 14:23:11,456 DEBUG : Generating results file: v8_7 14:23:11 INFO - 2015-12-05 14:23:11,456 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:11 INFO - 2015-12-05 14:23:11,524 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 14:23:11 INFO - 2015-12-05 14:23:11,525 DEBUG : process_Request line: dromaeo_css 6343.99 graph.html#tests=[[72,94,35]] 14:23:11 INFO - 2015-12-05 14:23:11,525 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:11 INFO - 2015-12-05 14:23:11,567 DEBUG : process_Request line: kraken 1510.90 graph.html#tests=[[232,94,35]] 14:23:11 INFO - 2015-12-05 14:23:11,567 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:23:11 INFO - 2015-12-05 14:23:11,613 DEBUG : process_Request line: v8_7 19716.10 graph.html#tests=[[230,94,35]] 14:23:11 INFO - 2015-12-05 14:23:11,614 INFO : javascript benchmark 14:23:11 INFO - 2015-12-05 14:23:11,618 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.0734239345034, 2651.535981203289, 2661.9600705989424, 2676.4245687177254, 2694.178275625934, 4391.0559229765595, 4491.258942274529, 4572.31415287707, 4605.240135377663, 4605.401297831281, 4595.632349412047, 4619.0, 4644.326572646964, 4653.208954477738, 4660.650451216164, 4230.365445183216, 4252.829886804524, 4305.138972205564, 4351.891202719926, 4383.430154079981, 4071.409645601386, 4299.118680670455, 4311.396404503372, 4363.956360436387, 4397.142557201347, 4203.117345357478, 4205.642520385741, 4222.071144348239, 4279.079997800457, 4311.0, 4285.0, 4320.848770293056, 4327.37253098299, 4359.760213188273, 4359.84740534083, 4046.514418269797, 4294.828206871722, 4301.139772045603, 4308.18144552534, 4350.0647360817575, 4451.2655411857, 4461.888452788674, 4470.709403888737, 4545.340925565807, 4572.405587273666, 5007.399112106534, 5026.29631851541, 5026.874328141789, 5027.044861476308, 5071.594272458195, 5022.748862556894, 5023.422306434771, 5031.22016087507, 5032.471590482984, 5049.520295571915, 4394.824207031715, 4503.842365517191, 4507.729536227836, 4580.358749775034, 4684.180268453007, 5049.116404629175, 5056.292119103328, 5066.290719299301, 5066.569341605931, 5067.290579318898, 4846.733429661403, 4858.076965376567, 4859.2954021667365, 4865.5864251538305, 4889.877753056131, 4718.811247550059, 4774.3077253798, 4795.256735206049, 4888.071266459361, 5010.223415370623, 4928.162212423897, 4949.604031677457, 4952.702837829742, 4957.454679985199, 4965.478624744422, 4949.084419382426, 4950.851474455772, 4950.876228094255, 4951.8266860659705, 4987.102321582078, 3917.373220284741, 3957.3470377387407, 4001.5398229204015, 4114.362273847559, 4160.771157586361, 3562.0, 3589.3539162950397, 3604.4052731299566, 3612.187257866959, 3628.63713628635, 4210.494740631144, 4316.525182229952, 4318.201132790381, 4350.934735978963, 4355.107203023373, 4699.154152252559, 4817.205161148441, 4818.8795280118275, 5009.348784658044, 5026.974865125724, 4110.260153172458, 4158.293090174617, 4165.250254954138, 4191.7275377100395, 4202.684798640114, 4343.1530851484285, 4350.695451318377, 4352.086061926968, 4353.281708518122, 4393.340998850134, 4539.319102134707, 4658.440987081572, 4659.2312268475325, 4688.64835137366, 4727.030958653537, 4846.757662116951, 4886.3647725796845, 4906.705597664151, 4908.754562271801, 4935.925961110514, 4740.146773580788, 4768.189407800613, 4770.403699537558, 4775.641826863069, 4778.450478195052, 4707.199776038014, 4834.419869615669, 4838.491958344323, 4958.677685950402, 4993.4756850530175, 4898.583620392164, 4943.110240156662, 4958.1323268428605, 4959.181735013826, 4994.750262486934, 4756.9762151189025, 4889.266610008385, 4889.90220195587, 4892.877678058077, 4925.236588328815, 4630.259158534618, 4762.071396077731, 4763.809447622057, 4861.635377346784, 4932.1122198004705, 4589.311603259538, 4640.74475903815, 4708.317293992283, 4726.527347265246, 4734.952650473589, 4817.614590832795, 4890.828820991248, 4901.877453063702, 4902.754862256802, 4904.5095490452095, 4799.784009719641, 4800.207965685623, 4802.567768900815, 4803.447603525639, 4815.9886423849985], "unit": "ms", "name": "dojo.html", "value": 4531.371417431284}, {"lowerIsBetter": false, "replicates": [552.7628512547909, 581.0847914534609, 587.3891153200669, 591.6272748168653, 594.9464548190667, 28267.717322826764, 29073.127806165798, 29079.12762617125, 29143.0, 29150.854245728795, 29772.213667179985, 30085.0, 30292.0, 37829.621703782956, 38521.61478385215, 7827.295543401078, 7933.761987140395, 7952.284294413502, 7960.48256863305, 7961.203879612021, 7875.291223789858, 7934.642941067666, 7963.800904977393, 7977.880331795028, 7990.12108668046, 7174.139103307611, 7376.74181403651, 10332.535035923402, 10602.52288647009, 10627.256092073558, 10006.849897251546, 10098.646547370807, 10103.797924041515, 10110.140638045776, 10111.3427627204, 7203.387712044482, 7389.261073892621, 9994.850077248848, 10154.492275386201, 10167.4916254187, 37570.624293756984, 38460.42309365362, 38491.80754096239, 38560.61439385598, 38591.22817543661, 2610.4779044191237, 2684.8657567121763, 2726.82275652082, 2742.3966727320158, 2870.2250392393935, 27080.0, 27919.162425127277, 27930.581041284397, 28026.439471210666, 28420.857895710596, 3391.9321613567836, 3408.5739282589675, 3445.3453843769603, 3520.4015317396106, 3587.766795158306, 220856.0, 221604.0, 221987.0, 222612.0, 223249.88375058182, 54073.72963135238, 54448.0, 54469.72765136149, 54475.0, 54508.72745636326, 58771.0, 58917.70541147267, 59023.704881475314, 59070.40929590649, 59087.0, 12910.28993405353, 13268.800967985488, 13270.1374410663, 13273.867261327263, 13299.601011969657, 10452.68641940743, 10496.212784041227, 10502.842457363146, 10505.0, 10513.684589462327, 17891.25099790063, 18427.328037434498, 18642.720359194624, 18646.254149833854, 18677.0, 7503.5497870127965, 7846.411519135973, 7924.762257132295, 7933.365330773524, 7948.324392426593, 860.7718954477068, 874.7550685807984, 910.0080911806031, 966.9315406475883, 995.4276291132628, 24064.639030414557, 25549.23352299434, 25604.615930761054, 25851.22446326613, 25885.74114258871, 872.5942436766807, 931.7344556801279, 979.1921664626711, 997.9550920208608, 1053.9565829828414, 12929.0, 13357.93321033408, 13359.53241636538, 13452.771494624643, 13959.0, 265446.0, 269847.0, 270184.0, 270607.0, 271008.0, 45648.54351456509, 45929.0, 45942.85142871455, 46049.76975115103, 46149.0, 1209.12338554549, 1244.6514975806788, 1254.021862946903, 1254.8055051467038, 1256.3215863433643, 25533.616995744705, 26294.868525658014, 26479.205623831316, 26755.19734407971, 26778.732212678402, 47028.7648561755, 48144.51855481401, 48154.27768583404, 48155.0, 48248.276275856595, 226665.0, 227056.0, 227593.0, 227672.0, 227836.0, 24902.750972490045, 25216.369590759645, 28377.574336384558, 30758.0, 31153.844230779607, 37332.440013400366, 37523.249535009694, 38214.80892595519, 38710.419343709305, 38737.418938715375, 32020.65139781373, 32173.356532868744, 32328.0, 33022.66977330292, 33375.49936750902, 25315.74684253134, 29814.85092574523, 32926.17684557809, 33219.50170747392, 33810.661893380755, 30638.387232254783, 30757.53863692091, 30853.8457307712, 30857.69142308638, 31007.68992310048, 27093.27828667256, 27515.0, 27767.444651107267, 28008.159755207376, 28013.439731205668, 22982.655260170777, 23483.295501134995, 23815.761842381355, 23826.046958122173, 23924.52150957006], "unit": "ms", "name": "ext.html", "value": 16785.259236561695}, {"lowerIsBetter": false, "replicates": [315.00615557914784, 330.9238875058735, 331.6452292385605, 331.6749585406302, 335.15373681454327, 12463.813042804366, 12777.616671499869, 15111.471098511554, 15470.535883923472, 15523.223838808057, 12662.11365204436, 15036.774448383283, 16038.518844434657, 16387.672246555063, 16535.255913483892, 4990.700557966534, 5021.397432308119, 5051.242313652963, 5058.747062646871, 5060.2409638554145, 3558.804265765382, 3648.2885837261742, 5054.140796064659, 5094.745262736867, 5585.972070139644, 5796.101604251347, 5811.0702287633985, 5832.096025116092, 5835.620684655505, 5837.766489340443, 5691.373948865621, 6014.308354539218, 6016.96991515044, 6021.066734656091, 6021.096835474692, 5194.844154675328, 5219.19102539107, 5239.607029472805, 5257.369115706101, 5259.921101183485, 19775.11012004449, 19814.900925495425, 19883.80116198834, 20151.79848201514, 20831.479213019644, 1788.0791392432907, 1870.8783929044705, 1905.3521802587047, 1965.1746266567932, 1975.0867470481069, 12428.440720167615, 12544.623661290176, 12653.0, 12864.09951303409, 12927.030472714585, 1657.991710041442, 1673.9246733897003, 1925.1914196037699, 1959.9118039688249, 2021.9090140943545, 60935.695321523555, 64324.356756432775, 65098.0, 65850.34149658537, 66466.66766666136, 15732.213389330716, 15738.0, 15739.527814165593, 15755.0, 15883.52349429519, 23361.182358617367, 23373.649395259086, 23627.7637223629, 23629.7637023631, 23653.881730591238, 8940.776480588038, 8948.120894612075, 8956.910430895608, 9011.459312441275, 9037.051109633525, 7594.886076708854, 7600.391968642495, 7602.049743782028, 7610.543367397974, 7650.655720492591, 7700.422468314899, 7717.2668596483245, 7725.304722574995, 7733.806654833562, 7734.265244801735, 1715.613986852973, 1724.7326664367042, 1742.8954262744276, 2193.4954960359205, 3045.1625802904377, 800.8638531449668, 810.1776696652902, 867.6312567158932, 901.2429559170197, 946.1579194516886, 16029.0, 16052.117133557766, 16115.19424028794, 16172.919135404247, 16457.506274811774, 827.5986146718836, 844.6536919862826, 857.9571021448903, 860.2988564320059, 861.586438509519, 8978.281737460988, 9168.724938251864, 9473.715788526355, 9497.857532137023, 9521.761955951157, 300204.0, 304437.0, 321047.0, 322851.0, 486050.0, 69987.30012699807, 76223.23776762272, 77883.22116778872, 78041.0, 78506.6074669623, 1027.075631931253, 1047.1308813684775, 1058.2747336907448, 1063.7340664833791, 1064.7018834726289, 13797.655058623615, 14453.132812030892, 14659.853401465849, 14697.485588004369, 15459.61350966235, 33670.831645841616, 34208.0, 34420.82789586036, 35339.11652208612, 35546.644533555365, 42261.57738422576, 43383.56616433795, 43911.34132987944, 44791.0, 46971.76514117407, 8903.777405564913, 8920.643174272956, 9039.954800225956, 9050.683226087056, 9133.680321188727, 16633.916830415772, 17067.0, 17072.57318567046, 17237.741433878753, 17405.912970435067, 13816.447342106605, 13999.930000349934, 14007.789883151558, 14071.507497237548, 14131.0, 13372.264525451194, 13474.326283685581, 13518.79721804154, 13673.111247768864, 13990.300484975507, 13803.0, 14044.438222470986, 14094.859051409354, 14128.717425651635, 14373.568792936228, 8782.956085219534, 8947.150020748019, 8950.104989501258, 9023.278137749096, 9062.139096785795, 10591.682249532527, 14203.573892783234, 14311.427542898167, 14330.856691432953, 14603.561893143222], "unit": "ms", "name": "jquery.html", "value": 9025.021694994502}, {"lowerIsBetter": false, "replicates": [1435.0958895895585, 1465.8900582456317, 1487.3084015932593, 1583.9683206335874, 1735.9045252511107, 5895.4104589541075, 7034.824129396761, 7201.279872012796, 7203.351698347148, 7208.819779505515, 7132.251113633071, 7260.0, 7268.96365518173, 7276.126864776221, 7276.708931642728, 1994.42161773086, 2017.7074324222979, 2021.858469907107, 2023.5548179400507, 2024.4230394337617, 2097.192580856366, 2130.7656157822626, 2137.1130980643015, 2137.1558234497365, 2138.2943628602525, 2038.9796102039013, 2045.0490521907311, 2063.350044735911, 2066.214838361428, 2074.636938535758, 2068.4932191613075, 2093.8324934005245, 2103.7265155529685, 2105.9999999999923, 2110.7256056712604, 2063.8039386258283, 2073.1603700501323, 2101.7898210179014, 2102.0225595098354, 2105.3683894831643, 7171.462140339496, 7251.093613298338, 7270.927290727078, 7276.745313913988, 7276.762950298462, 4041.232165888501, 4138.110306284163, 4138.979305103455, 4143.212789569972, 4148.419221309019, 2613.2552222616655, 2636.8154229203965, 2667.906623268176, 2667.9733202667917, 2670.572708366652, 853.4921721575653, 855.7304449098576, 868.3096937934357, 883.465503370458, 885.7608445719619, 9749.805003899954, 9787.0, 9789.412635241908, 9794.706158815317, 9803.068708472683, 3851.2490064437725, 3853.865114720971, 3916.804159792056, 3953.92092158161, 3962.5244970603712, 8365.539895305696, 8406.621702023423, 8412.116727743622, 8417.537035462985, 8422.410431269753, 4256.6807489438415, 4282.272013757606, 4301.763403012865, 4303.332983387518, 4303.462067241595, 3162.4623813951684, 3234.951475727866, 3786.1670432504807, 3898.4542164097047, 3899.200663863901, 3476.3394954958476, 3504.0889368764306, 3523.1544429336773, 3524.6299138590593, 3559.2169722660974, 1108.5731993182521, 1112.449337577904, 1131.886811318878, 1138.3170097941334, 1143.1197977557401, 1156.4160099149876, 1163.627639155479, 1165.5454372794618, 1177.4877928101303, 1178.2753606531921, 6597.60414375139, 6620.668966551653, 6632.369924857131, 6668.133142691419, 6710.127683401127, 419.5291298926741, 428.0070237050076, 431.5102358822759, 432.15729327810897, 432.47022397563364, 5433.1035379161995, 5438.238646589481, 5446.101393270066, 5453.972730136404, 5459.563234941195, 7837.843243135106, 7992.640331185111, 8572.228499435081, 8704.955405351398, 8745.693900713444, 7892.802679933047, 7934.087579928267, 7997.800054998555, 8002.679892804223, 8024.478408903403, 6767.424768894699, 6812.386885180357, 6861.519693621499, 6868.381845633917, 6877.6217308048535, 6775.119234499483, 6846.657667116525, 6855.211650660238, 6857.314268573103, 6859.725610975505, 7557.4331925106935, 7813.296803287504, 7815.140334563307, 7879.054513458422, 7939.682412703427, 7662.501937374052, 7896.802579935547, 7916.525008499509, 7980.441369104107, 8031.718889839061, 5449.536789372948, 5551.417101204315, 6328.873422531616, 6397.392247736458, 6471.094046833353, 7037.401820845081, 7069.9646501767165, 7093.0, 7107.538010029331, 7124.3944264738075, 6366.681665916778, 6502.512311576556, 6519.608823470607, 6595.142631457879, 6598.04328372393, 6422.582532135396, 6430.356964303533, 6588.143541339787, 6643.970184621391, 6661.467082633475, 6211.751529938932, 6289.496840252677, 6291.370862913672, 6296.905546416716, 6299.590526615755, 5777.277840269966, 5799.101139323411, 5815.94184058154, 5894.646321220741, 5896.439838215363, 5579.358373787067, 5604.943950560442, 5617.4101719320515, 5617.634853734494, 5621.831345059655], "unit": "ms", "name": "mootools.html", "value": 4012.873497064886}, {"lowerIsBetter": false, "replicates": [278.6558600128841, 281.2504675041016, 284.7679141499677, 285.8813592359172, 289.37783764905436, 5209.739513024352, 5296.920546191805, 5300.204969254609, 5339.385970613381, 5352.090144675405, 5239.318888544484, 5303.7082960437165, 5310.0441920454305, 5313.707746073965, 5314.707691076989, 4004.1991601679633, 4011.1576568920414, 4014.799260037001, 4016.839326426954, 4017.8191981360837, 3820.7134464915102, 3941.3496773032416, 3988.9202215955665, 4008.7394319369146, 4058.6753059755147, 4029.476168098158, 4029.6171863672903, 4047.8583249586272, 4048.251073551388, 4062.2890994076065, 3821.426785982125, 4027.939580906289, 4038.232735780222, 4039.919201615966, 4043.5147782266167, 3409.7442691798215, 3437.106352348407, 3516.472529120627, 3518.085297822559, 3545.9113522161892, 5092.261622064817, 5098.745062746848, 5104.64267501275, 5110.488951104897, 5114.207297868837, 4598.103369842882, 4635.443746750378, 4636.0, 4638.1187574360765, 4638.281066434708, 5390.73046347685, 5498.202760599731, 5506.339239291271, 5507.118860982264, 5512.090505066659, 3819.3316169670475, 3827.4067519534237, 3827.827747751358, 3829.3872980323295, 3832.827522761482, 5700.344460387026, 5790.073588225863, 5794.420557944214, 5797.449242321973, 5801.88396232073, 3952.8418863245147, 3963.147923196469, 3964.682825373963, 3964.742291751027, 3964.980175099106, 4004.8598299059395, 4028.5971402860064, 4033.616806403387, 4036.3138266494766, 4037.596240375939, 4489.977550112294, 4609.838655647036, 4610.2623580227, 4616.28447590624, 4621.329907163443, 5536.944630553643, 5540.695261760642, 5541.695206763586, 5542.418046105182, 5544.362398324163, 1390.9026368154334, 1400.8949328800381, 1402.593247958101, 1404.3539971612968, 1405.845357010728, 948.127722495306, 948.4451595816524, 951.5955718819613, 972.2999440402899, 975.4488713876636, 4829.1790395632825, 4835.492273311322, 4845.224764037807, 4848.345473361122, 4850.6362022848425, 5722.971385143131, 5725.713714314267, 5730.541556675456, 5732.05421105513, 5733.426657334233, 4802.51974802517, 4811.158047341702, 4846.055019271279, 4849.175640141185, 4855.101806165871, 3009.7441717453826, 3062.0354588304613, 3086.0279012111114, 3086.6141732283463, 3087.7838551301193, 5250.081235783722, 5328.120860058047, 5377.919331210035, 5473.917891231635, 5478.58910581708, 5902.527797776168, 5929.762809487572, 5930.347661757203, 5933.614315069507, 5943.821685349447, 5449.427810079885, 5454.53636440899, 5454.536364409069, 5467.425920278393, 5469.07025805606, 5629.6903670298525, 5779.624324418899, 5782.681952492653, 5787.884242315215, 5789.363170051207, 5655.0, 5657.519110875622, 5662.122371032497, 5667.093265077568, 5667.971660141673, 5460.91808622863, 5462.863428414322, 5463.289772329572, 5471.945280547144, 5479.6164268500825, 3967.5238971323624, 3974.28462876685, 3974.6224108709625, 3977.125032492847, 3979.880603581897, 5626.35296940857, 5769.0, 5780.913286300793, 5782.508486778503, 5784.4504772046585, 5560.694161821139, 5567.55459563242, 5569.693666848362, 5582.7766889323975, 5583.190437386637, 5555.0834112371, 5556.305461817273, 5560.555155587463, 5560.888782224414, 5572.442755724395, 5297.099493086108, 5450.046241907571, 5452.754626041917, 5476.753546090516, 5477.917831232615, 5622.522085622768, 5624.971875140598, 5626.07169816992, 5627.634203776742, 5632.464915832989, 5460.31746031746, 5463.0, 5463.644863083887, 5471.015217260931, 5471.06991811401], "unit": "ms", "name": "prototype.html", "value": 4144.039136263478}, {"lowerIsBetter": false, "replicates": [781.0354212547503, 781.6326326626486, 787.2167193642326, 797.9601019949005, 815.1359558867597, 10890.0, 11105.777884442326, 11110.277831940919, 11136.554537818487, 11139.498722557484, 11747.53009879606, 11834.7633047339, 11875.16873818833, 11879.406029698524, 11880.881191188108, 625.5996162456021, 638.7891995641427, 796.8764841449556, 810.8094597769519, 814.1451475950258, 803.0122948772984, 808.4744915804715, 810.5987536169604, 812.959352032399, 815.2255357410484, 838.6393850644251, 845.3617518773349, 845.4504572028169, 847.3729440214258, 851.3997631669689, 650.7429565321695, 655.0370954696589, 835.07723965019, 847.8812966184739, 849.2569002123142, 630.1398590923402, 630.7319389259546, 633.2306247908767, 633.5533448918501, 634.3054355480788, 12277.079219058607, 12297.877021229851, 12305.323207223599, 12329.075319351085, 12351.876481235162, 11362.829557556643, 11646.708832279177, 11706.414679266003, 11985.880141198564, 12177.025837933033, 9226.58480368385, 9409.309454743332, 9525.19035881951, 9658.855117173178, 9661.178799802025, 3277.147941535218, 3285.65500622436, 3286.901392958215, 3311.4701647736247, 3364.764466487347, 38778.418323725164, 38857.417138742945, 39142.0, 39244.80377598122, 39313.21373572541, 9467.621295148254, 9554.761130971781, 9585.376950498196, 9702.0, 9779.951100244452, 16048.358065677243, 16118.75821862673, 16162.515124546282, 16163.191840407933, 16184.0, 5921.2302400688495, 6065.787697430569, 6094.542909281821, 6205.131281620576, 6286.811395658046, 3580.445031020196, 3637.8181090945345, 3674.338619048597, 3680.5215322007966, 3680.8895733128047, 2655.946881062368, 2716.2937636214333, 2720.374313907773, 2722.3602453423428, 2726.700062993069, 468.292877754593, 472.9243321068681, 474.240567494592, 485.81296200962885, 488.101892517769, 465.26456317934293, 514.7477735909378, 533.1789044870933, 551.4650788734921, 595.1162523652373, 7512.173660897297, 7654.655540500691, 7674.270944260286, 7702.114256860533, 7755.650995705207, 443.71380459603375, 529.3145376737135, 591.9437653422918, 593.8693487432757, 605.5972778102513, 3507.5790905091553, 3725.4784330193793, 4050.3924411338535, 4148.0, 4288.849890253889, 49901.0, 50018.74990625097, 50275.0, 50343.0, 50539.74730126326, 40676.59323406787, 41557.168856622695, 41561.0, 41565.1686966259, 41649.0, 38445.2310953785, 38840.0, 39244.60755392467, 39293.803530982164, 39574.60425395709, 7906.683732650629, 7938.982681732788, 8068.677252909818, 8308.086110527716, 8395.943365816356, 30667.693323066484, 30867.228319292197, 31135.688643114187, 31315.217119572193, 31617.5257371135, 40293.39559906545, 41008.79495602503, 41507.37738933979, 41759.791201045016, 41762.164756704085, 10020.749481263027, 10134.493275336055, 10193.133583645176, 10208.693739187836, 10253.0, 10778.407187604756, 11052.0, 11256.437178141225, 11516.769664606494, 11703.063754899758, 10166.135878450414, 10175.08424241792, 10180.440075795903, 10262.230332724926, 10949.288296260718, 10605.41670208146, 10978.176636752436, 11053.944730276296, 11065.668029959113, 11385.658430247106, 8401.579921004048, 9860.457674827954, 10338.224633152393, 11063.889361106609, 11150.553977840795, 9030.179889984533, 9064.546772661208, 9269.397489163182, 9430.811383772423, 9561.187299079656, 8974.102589740975, 9049.0, 9150.450972941644, 9204.0, 9235.722928312161], "unit": "ms", "name": "yui.html", "value": 5710.055120832847}], "name": "dromaeo_css", "value": 6343.987095894842}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 114.0, 105.0, 112.0, 111.0, 112.0, 100.0, 111.0, 111.0, 102.0], "unit": "ms", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 153.0, 165.0, 127.0, 158.0, 154.0, 129.0, 167.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [75.0, 72.0, 85.0, 92.0, 72.0, 72.0, 72.0, 122.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 94.0, 94.0, 95.0, 136.0, 95.0, 96.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 158.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 70.0, 71.0, 71.0, 72.0, 70.0, 73.0, 70.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 84.0, 85.0, 85.0, 83.0, 84.0, 85.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [116.0, 118.0, 124.0, 115.0, 119.0, 126.0, 120.0, 125.0, 130.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.0}, {"lowerIsBetter": true, "replicates": [131.0, 152.0, 156.0, 147.0, 145.0, 132.0, 143.0, 145.0, 142.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [69.0, 67.0, 67.0, 69.0, 69.0, 67.0, 67.0, 68.0, 67.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1510.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.97510373443984], "unit": "score", "name": "Richards", "value": 212.69455}, {"lowerIsBetter": false, "replicates": [184.77457501847746], "unit": "score", "name": "DeltaBlue", "value": 357.83061599999996}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [783.6990595611285], "unit": "score", "name": "Earley", "value": 850.4067880000003}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [28714.285714285714], "unit": "score", "name": "RegExp", "value": 31.725845771144286}, {"lowerIsBetter": false, "replicates": [603.864734299517], "unit": "score", "name": "Splay", "value": 134.94909600000005}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19716.10046617306}]} 14:23:11 INFO - RETURN: dromaeo_css: 6343.99 14:23:11 INFO - RETURN: kraken: 1510.90 14:23:11 INFO - RETURN: v8_7: 19716.10 14:23:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19716.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1510.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6343.99"}}} 14:23:11 INFO - Return code: 0 14:23:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:23:11 ERROR - # TBPL SUCCESS # 14:23:11 INFO - Running post-action listener: _resource_record_post_action 14:23:11 INFO - Running post-run listener: _resource_record_post_run 14:23:12 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507580416; Read time: 16; Write time: 467124 14:23:12 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231247872; Read time: 0; Write time: 341288 14:23:12 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276332544; Read time: 16; Write time: 125836 14:23:12 INFO - Running post-run listener: _upload_blobber_files 14:23:12 INFO - Blob upload gear active. 14:23:12 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:23:12 INFO - Copying logs to upload dir... 14:23:12 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.163408 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-05 14:23:12.089997) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:23:12.093723) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009230 build_url: 'https://queue.taskcluster.net/v1/task/eIQz-KcRSNmVftlBrB18tQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-05 14:23:12.147191) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:23:12.147636) ========= 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=6ea65ccfe4e6b94e0d4f826f000001d8-1449352525.217248-1512918521 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-05 14:23:12.196829) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 14:23:12.197151) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-05 14:23:12.197442) ========= ========= Total master_lag: 0.26 =========