builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1450182637.78 results: success (0) buildid: 20151215030512 builduid: f0cbc7221a204f9885cb4fd16853d8ec revision: 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.776157) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.776750) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.777113) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006362 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.825044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.825429) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.905124) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.905440) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.954936) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.955284) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.955726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:37.956095) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 04:30:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.2M=0s 2015-12-15 04:30:40 (41.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192017 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:38.182139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:38.182481) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013824 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:38.243029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 04:30:38.243428) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 --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 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 --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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 04:30:40,523 truncating revision to first 12 chars 2015-12-15 04:30:40,523 Setting DEBUG logging. 2015-12-15 04:30:40,523 attempt 1/10 2015-12-15 04:30:40,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7a22b7a21f27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 04:30:41,670 unpacking tar archive at: mozilla-central-7a22b7a21f27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.453660 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-15 04:30:39.713244) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:39.713625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:39.723890) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:39.724360) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 04:30:39.725187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-15 04:30:39.725555) ========= /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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:30:42 INFO - MultiFileLogger online at 20151215 04:30:42 in /builds/slave/test 04:30:42 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 04:30:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:30:42 INFO - {'append_to_log': False, 04:30:42 INFO - 'base_work_dir': '/builds/slave/test', 04:30:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:30:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:30:42 INFO - 'branch': 'Firefox-Non-PGO', 04:30:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:30:42 INFO - 'config_files': ('talos/linux_config.py',), 04:30:42 INFO - 'default_actions': ('clobber', 04:30:42 INFO - 'read-buildbot-config', 04:30:42 INFO - 'download-and-extract', 04:30:42 INFO - 'populate-webroot', 04:30:42 INFO - 'create-virtualenv', 04:30:42 INFO - 'install', 04:30:42 INFO - 'run-tests'), 04:30:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:30:42 INFO - 'download_minidump_stackwalk': True, 04:30:42 INFO - 'download_symbols': 'ondemand', 04:30:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:30:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:30:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:30:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:30:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:30:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:30:42 INFO - 'installer_path': 'installer.exe', 04:30:42 INFO - 'log_level': 'info', 04:30:42 INFO - 'log_name': 'talos', 04:30:42 INFO - 'log_to_console': True, 04:30:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:30:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:30:42 INFO - 'opt_config_files': (), 04:30:42 INFO - 'pip_index': False, 04:30:42 INFO - 'sps_profile': False, 04:30:42 INFO - 'sps_profile_interval': 0, 04:30:42 INFO - 'suite': 'dromaeojs', 04:30:42 INFO - 'system_bits': '64', 04:30:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:30:42 INFO - 'title': 'talos-linux64-ix-068', 04:30:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:30:42 INFO - 'use_talos_json': True, 04:30:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:30:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:30:42 INFO - 'work_dir': 'build'} 04:30:42 INFO - ##### 04:30:42 INFO - ##### Running clobber step. 04:30:42 INFO - ##### 04:30:42 INFO - Running pre-action listener: _resource_record_pre_action 04:30:42 INFO - Running main action method: clobber 04:30:42 INFO - rmtree: /builds/slave/test/build 04:30:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:30:43 INFO - Running post-action listener: _resource_record_post_action 04:30:43 INFO - ##### 04:30:43 INFO - ##### Running read-buildbot-config step. 04:30:43 INFO - ##### 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: read_buildbot_config 04:30:43 INFO - Using buildbot properties: 04:30:43 INFO - { 04:30:43 INFO - "properties": { 04:30:43 INFO - "buildnumber": 404, 04:30:43 INFO - "product": "firefox", 04:30:43 INFO - "script_repo_revision": "production", 04:30:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:30:43 INFO - "repository": "", 04:30:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:30:43 INFO - "buildid": "20151215030512", 04:30:43 INFO - "slavename": "talos-linux64-ix-068", 04:30:43 INFO - "pgo_build": "False", 04:30:43 INFO - "basedir": "/builds/slave/test", 04:30:43 INFO - "project": "", 04:30:43 INFO - "platform": "ubuntu64_hw", 04:30:43 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:30:43 INFO - "slavebuilddir": "test", 04:30:43 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:30:43 INFO - "branch": "mozilla-central", 04:30:43 INFO - "repo_path": "mozilla-central", 04:30:43 INFO - "stage_platform": "linux64", 04:30:43 INFO - "builduid": "f0cbc7221a204f9885cb4fd16853d8ec", 04:30:43 INFO - "revision": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636" 04:30:43 INFO - }, 04:30:43 INFO - "sourcestamp": { 04:30:43 INFO - "repository": "", 04:30:43 INFO - "hasPatch": false, 04:30:43 INFO - "project": "", 04:30:43 INFO - "branch": "mozilla-central-linux64-talos", 04:30:43 INFO - "changes": [ 04:30:43 INFO - { 04:30:43 INFO - "category": null, 04:30:43 INFO - "files": [ 04:30:43 INFO - { 04:30:43 INFO - "url": null, 04:30:43 INFO - "name": "https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 04:30:43 INFO - } 04:30:43 INFO - ], 04:30:43 INFO - "repository": "", 04:30:43 INFO - "rev": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636", 04:30:43 INFO - "who": "cbook@mozilla.com", 04:30:43 INFO - "when": 1450182624, 04:30:43 INFO - "number": 7361742, 04:30:43 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:30:43 INFO - "project": "", 04:30:43 INFO - "at": "Tue 15 Dec 2015 04:30:24", 04:30:43 INFO - "branch": "mozilla-central-linux64-talos", 04:30:43 INFO - "revlink": "", 04:30:43 INFO - "properties": [ 04:30:43 INFO - [ 04:30:43 INFO - "buildid", 04:30:43 INFO - "20151215030512", 04:30:43 INFO - "Change" 04:30:43 INFO - ], 04:30:43 INFO - [ 04:30:43 INFO - "builduid", 04:30:43 INFO - "f0cbc7221a204f9885cb4fd16853d8ec", 04:30:43 INFO - "Change" 04:30:43 INFO - ], 04:30:43 INFO - [ 04:30:43 INFO - "pgo_build", 04:30:43 INFO - "False", 04:30:43 INFO - "Change" 04:30:43 INFO - ] 04:30:43 INFO - ], 04:30:43 INFO - "revision": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636" 04:30:43 INFO - } 04:30:43 INFO - ], 04:30:43 INFO - "revision": "7a22b7a21f27e5adc8d71f40d6035c2402e0a636" 04:30:43 INFO - } 04:30:43 INFO - } 04:30:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:30:43 INFO - Running post-action listener: _resource_record_post_action 04:30:43 INFO - ##### 04:30:43 INFO - ##### Running download-and-extract step. 04:30:43 INFO - ##### 04:30:43 INFO - Running pre-action listener: _resource_record_pre_action 04:30:43 INFO - Running main action method: download_and_extract 04:30:43 INFO - mkdir: /builds/slave/test/build/tests 04:30:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:43 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json 04:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json 04:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:30:52 INFO - Downloaded 1302 bytes. 04:30:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:30:52 INFO - Using the following test package requirements: 04:30:52 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:52 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:30:52 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'jsshell-linux-x86_64.zip'], 04:30:52 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:30:52 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:52 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:30:52 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:30:52 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:30:52 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:30:52 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:30:52 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:30:52 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:52 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:54 INFO - Downloaded 21869726 bytes. 04:30:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:30:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:30:55 INFO - Return code: 0 04:30:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:30:55 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:30:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:30:59 INFO - Downloaded 21869726 bytes. 04:30:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 04:30:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:30:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:31:00 INFO - Return code: 0 04:31:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:00 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:31:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:01 INFO - Downloaded 11132038 bytes. 04:31:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 04:31:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:01 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:31:01 INFO - Return code: 0 04:31: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')]} 04:31:01 INFO - https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:31:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:31:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:31:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:31:02 INFO - Downloaded 57743688 bytes. 04:31:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:31:02 INFO - mkdir: /builds/slave/test/properties 04:31:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:02 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:02 INFO - Contents: 04:31:02 INFO - build_url:https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:31:02 INFO - Running post-action listener: _resource_record_post_action 04:31:02 INFO - Running post-action listener: set_extra_try_arguments 04:31:02 INFO - ##### 04:31:02 INFO - ##### Running populate-webroot step. 04:31:02 INFO - ##### 04:31:02 INFO - Running pre-action listener: _resource_record_pre_action 04:31:02 INFO - Running main action method: populate_webroot 04:31:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:02 INFO - '--tppagecycles', 04:31:02 INFO - '7'], 04:31:02 INFO - 'tests': ['tsvgm']}}, 04:31:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:31:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:31:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:31:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'tests': ['damp', 'tps']}, 04:31:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['damp', 'tps']}, 04:31:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:31:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:02 INFO - 'other': {'tests': ['a11yr', 04:31:02 INFO - 'ts_paint', 04:31:02 INFO - 'tpaint', 04:31:02 INFO - 'sessionrestore', 04:31:02 INFO - 'sessionrestore_no_auto_restore']}, 04:31:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['a11yr', 04:31:02 INFO - 'ts_paint', 04:31:02 INFO - 'tpaint', 04:31:02 INFO - 'sessionrestore', 04:31:02 INFO - 'sessionrestore_no_auto_restore']}, 04:31:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['a11yr', 04:31:02 INFO - 'ts_paint', 04:31:02 INFO - 'tpaint', 04:31:02 INFO - 'sessionrestore', 04:31:02 INFO - 'sessionrestore_no_auto_restore']}, 04:31:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['a11yr', 04:31:02 INFO - 'ts_paint', 04:31:02 INFO - 'tpaint', 04:31:02 INFO - 'sessionrestore', 04:31:02 INFO - 'sessionrestore_no_auto_restore']}, 04:31:02 INFO - 'other_l64': {'tests': ['a11yr', 04:31:02 INFO - 'ts_paint', 04:31:02 INFO - 'tpaint', 04:31:02 INFO - 'sessionrestore', 04:31:02 INFO - 'sessionrestore_no_auto_restore']}, 04:31:02 INFO - 'other_nol64': {'tests': ['a11yr', 04:31:02 INFO - 'ts_paint', 04:31:02 INFO - 'tpaint', 04:31:02 INFO - 'sessionrestore', 04:31:02 INFO - 'sessionrestore_no_auto_restore']}, 04:31:02 INFO - 'svgr': {'tests': ['tsvgx', 04:31:02 INFO - 'tsvgr_opacity', 04:31:02 INFO - 'tart', 04:31:02 INFO - 'tscrollx', 04:31:02 INFO - 'cart']}, 04:31:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['tsvgx', 04:31:02 INFO - 'tsvgr_opacity', 04:31:02 INFO - 'tart', 04:31:02 INFO - 'tscrollx', 04:31:02 INFO - 'cart']}, 04:31:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'tests': ['tp5o']}, 04:31:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'talos_options': ['--e10s'], 04:31:02 INFO - 'tests': ['tp5o']}, 04:31:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'talos_options': ['--xperf_path', 04:31:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:02 INFO - 'tests': ['tp5n']}, 04:31:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:02 INFO - 'talos_options': ['--e10s', 04:31:02 INFO - '--xperf_path', 04:31:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:02 INFO - 'tests': ['tp5n']}}, 04:31:02 INFO - 'talos.zip': {'path': '', 04:31:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:02 INFO - Running post-action listener: _resource_record_post_action 04:31:02 INFO - ##### 04:31:02 INFO - ##### Running create-virtualenv step. 04:31:02 INFO - ##### 04:31:02 INFO - Running pre-action listener: _resource_record_pre_action 04:31:02 INFO - Running main action method: create_virtualenv 04:31:02 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:02 INFO - Using real prefix '/usr' 04:31:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:03 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:05 INFO - Installing pip.................done. 04:31:05 INFO - Return code: 0 04:31:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:05 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:05 INFO - Using env: {'DISPLAY': ':0', 04:31:05 INFO - 'HOME': '/home/cltbld', 04:31:05 INFO - 'LANG': 'en_US.UTF-8', 04:31:05 INFO - 'LANGUAGE': 'en_US:en', 04:31:05 INFO - 'LOGNAME': 'cltbld', 04:31:05 INFO - 'MAIL': '/var/mail/cltbld', 04:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:05 INFO - 'MOZ_NO_REMOTE': '1', 04:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:05 INFO - 'NO_EM_RESTART': '1', 04:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:05 INFO - 'PWD': '/builds/slave/test', 04:31:05 INFO - 'SHELL': '/bin/bash', 04:31:05 INFO - 'SHLVL': '1', 04:31:05 INFO - 'TERM': 'linux', 04:31:05 INFO - 'TMOUT': '86400', 04:31:05 INFO - 'USER': 'cltbld', 04:31:05 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:05 INFO - '_': '/tools/buildbot/bin/python'} 04:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:05 INFO - Cleaning up... 04:31:05 INFO - Return code: 0 04:31:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:05 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:31:05 INFO - Using env: {'DISPLAY': ':0', 04:31:05 INFO - 'HOME': '/home/cltbld', 04:31:05 INFO - 'LANG': 'en_US.UTF-8', 04:31:05 INFO - 'LANGUAGE': 'en_US:en', 04:31:05 INFO - 'LOGNAME': 'cltbld', 04:31:05 INFO - 'MAIL': '/var/mail/cltbld', 04:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:05 INFO - 'MOZ_NO_REMOTE': '1', 04:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:05 INFO - 'NO_EM_RESTART': '1', 04:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:05 INFO - 'PWD': '/builds/slave/test', 04:31:05 INFO - 'SHELL': '/bin/bash', 04:31:05 INFO - 'SHLVL': '1', 04:31:05 INFO - 'TERM': 'linux', 04:31:05 INFO - 'TMOUT': '86400', 04:31:05 INFO - 'USER': 'cltbld', 04:31:05 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:05 INFO - '_': '/tools/buildbot/bin/python'} 04:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:05 INFO - Downloading/unpacking psutil>=0.7.1 04:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:07 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:31:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:07 INFO - Installing collected packages: psutil 04:31:07 INFO - Running setup.py install for psutil 04:31:07 INFO - building 'psutil._psutil_linux' extension 04:31:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:31:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:31:07 INFO - building 'psutil._psutil_posix' extension 04:31:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:31:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:07 INFO - Successfully installed psutil 04:31:07 INFO - Cleaning up... 04:31:08 INFO - Return code: 0 04:31:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:08 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:31:08 INFO - Using env: {'DISPLAY': ':0', 04:31:08 INFO - 'HOME': '/home/cltbld', 04:31:08 INFO - 'LANG': 'en_US.UTF-8', 04:31:08 INFO - 'LANGUAGE': 'en_US:en', 04:31:08 INFO - 'LOGNAME': 'cltbld', 04:31:08 INFO - 'MAIL': '/var/mail/cltbld', 04:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:08 INFO - 'MOZ_NO_REMOTE': '1', 04:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:08 INFO - 'NO_EM_RESTART': '1', 04:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:08 INFO - 'PWD': '/builds/slave/test', 04:31:08 INFO - 'SHELL': '/bin/bash', 04:31:08 INFO - 'SHLVL': '1', 04:31:08 INFO - 'TERM': 'linux', 04:31:08 INFO - 'TMOUT': '86400', 04:31:08 INFO - 'USER': 'cltbld', 04:31:08 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:08 INFO - '_': '/tools/buildbot/bin/python'} 04:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:31:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:31:10 INFO - Installing collected packages: mozsystemmonitor 04:31:10 INFO - Running setup.py install for mozsystemmonitor 04:31:10 INFO - Successfully installed mozsystemmonitor 04:31:10 INFO - Cleaning up... 04:31:10 INFO - Return code: 0 04:31:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:10 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:10 INFO - Using env: {'DISPLAY': ':0', 04:31:10 INFO - 'HOME': '/home/cltbld', 04:31:10 INFO - 'LANG': 'en_US.UTF-8', 04:31:10 INFO - 'LANGUAGE': 'en_US:en', 04:31:10 INFO - 'LOGNAME': 'cltbld', 04:31:10 INFO - 'MAIL': '/var/mail/cltbld', 04:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:10 INFO - 'MOZ_NO_REMOTE': '1', 04:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:10 INFO - 'NO_EM_RESTART': '1', 04:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:10 INFO - 'PWD': '/builds/slave/test', 04:31:10 INFO - 'SHELL': '/bin/bash', 04:31:10 INFO - 'SHLVL': '1', 04:31:10 INFO - 'TERM': 'linux', 04:31:10 INFO - 'TMOUT': '86400', 04:31:10 INFO - 'USER': 'cltbld', 04:31:10 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:10 INFO - '_': '/tools/buildbot/bin/python'} 04:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:12 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:12 INFO - Downloading docopt-0.6.1.tar.gz 04:31:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:12 INFO - Running setup.py install for blobuploader 04:31:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:12 INFO - Running setup.py install for requests 04:31:13 INFO - Running setup.py install for docopt 04:31:13 INFO - Successfully installed blobuploader requests docopt 04:31:13 INFO - Cleaning up... 04:31:13 INFO - Return code: 0 04:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:13 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:13 INFO - Using env: {'DISPLAY': ':0', 04:31:13 INFO - 'HOME': '/home/cltbld', 04:31:13 INFO - 'LANG': 'en_US.UTF-8', 04:31:13 INFO - 'LANGUAGE': 'en_US:en', 04:31:13 INFO - 'LOGNAME': 'cltbld', 04:31:13 INFO - 'MAIL': '/var/mail/cltbld', 04:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:13 INFO - 'MOZ_NO_REMOTE': '1', 04:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:13 INFO - 'NO_EM_RESTART': '1', 04:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:13 INFO - 'PWD': '/builds/slave/test', 04:31:13 INFO - 'SHELL': '/bin/bash', 04:31:13 INFO - 'SHLVL': '1', 04:31:13 INFO - 'TERM': 'linux', 04:31:13 INFO - 'TMOUT': '86400', 04:31:13 INFO - 'USER': 'cltbld', 04:31:13 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:13 INFO - '_': '/tools/buildbot/bin/python'} 04:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:13 INFO - Running setup.py (path:/tmp/pip-CawJ05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:13 INFO - Running setup.py (path:/tmp/pip-UpsT_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:13 INFO - Running setup.py (path:/tmp/pip-IOJ29Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:13 INFO - Running setup.py (path:/tmp/pip-FyPf7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:13 INFO - Running setup.py (path:/tmp/pip-FpLsDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:13 INFO - Running setup.py (path:/tmp/pip-eUjOYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:14 INFO - Running setup.py (path:/tmp/pip-OwgK4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:14 INFO - Running setup.py (path:/tmp/pip-4cV3R7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:14 INFO - Running setup.py (path:/tmp/pip-nqBsZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:14 INFO - Running setup.py (path:/tmp/pip-LaiMQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:14 INFO - Running setup.py (path:/tmp/pip-pjcPSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:14 INFO - Running setup.py (path:/tmp/pip-cfFecv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:14 INFO - Running setup.py (path:/tmp/pip-drFxTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:14 INFO - Running setup.py (path:/tmp/pip-4i8iz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:14 INFO - Running setup.py (path:/tmp/pip-yitgqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:14 INFO - Running setup.py (path:/tmp/pip-Xg5rAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:14 INFO - Running setup.py (path:/tmp/pip-lIl_iA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:14 INFO - Running setup.py install for manifestparser 04:31:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:14 INFO - Running setup.py install for mozcrash 04:31:14 INFO - Running setup.py install for mozdebug 04:31:15 INFO - Running setup.py install for mozdevice 04:31:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozfile 04:31:15 INFO - Running setup.py install for mozhttpd 04:31:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozinfo 04:31:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozInstall 04:31:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozleak 04:31:15 INFO - Running setup.py install for mozlog 04:31:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for moznetwork 04:31:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:15 INFO - Running setup.py install for mozprocess 04:31:16 INFO - Running setup.py install for mozprofile 04:31:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozrunner 04:31:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Running setup.py install for mozscreenshot 04:31:16 INFO - Running setup.py install for moztest 04:31:16 INFO - Running setup.py install for mozversion 04:31:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:16 INFO - Cleaning up... 04:31:16 INFO - Return code: 0 04:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31: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')]} 04:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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')]} 04:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31: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', '-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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:16 INFO - Using env: {'DISPLAY': ':0', 04:31:16 INFO - 'HOME': '/home/cltbld', 04:31:16 INFO - 'LANG': 'en_US.UTF-8', 04:31:16 INFO - 'LANGUAGE': 'en_US:en', 04:31:16 INFO - 'LOGNAME': 'cltbld', 04:31:16 INFO - 'MAIL': '/var/mail/cltbld', 04:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:16 INFO - 'MOZ_NO_REMOTE': '1', 04:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:16 INFO - 'NO_EM_RESTART': '1', 04:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:16 INFO - 'PWD': '/builds/slave/test', 04:31:16 INFO - 'SHELL': '/bin/bash', 04:31:16 INFO - 'SHLVL': '1', 04:31:16 INFO - 'TERM': 'linux', 04:31:16 INFO - 'TMOUT': '86400', 04:31:16 INFO - 'USER': 'cltbld', 04:31:16 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:16 INFO - '_': '/tools/buildbot/bin/python'} 04:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:16 INFO - Running setup.py (path:/tmp/pip-PczROB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:16 INFO - Running setup.py (path:/tmp/pip-HmDvdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:16 INFO - Running setup.py (path:/tmp/pip-8PvMkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:17 INFO - Running setup.py (path:/tmp/pip-pL83R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:17 INFO - Running setup.py (path:/tmp/pip-F6KdbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:17 INFO - Running setup.py (path:/tmp/pip-n_0zVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:17 INFO - Running setup.py (path:/tmp/pip-6B2GYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:17 INFO - Running setup.py (path:/tmp/pip-AmRoM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:17 INFO - Running setup.py (path:/tmp/pip-i0EVc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:17 INFO - Running setup.py (path:/tmp/pip-LBzZm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:17 INFO - Running setup.py (path:/tmp/pip-hLbQ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:17 INFO - Running setup.py (path:/tmp/pip-wZpGzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:17 INFO - Running setup.py (path:/tmp/pip-3hYOQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:17 INFO - Running setup.py (path:/tmp/pip-hEKvDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:17 INFO - Running setup.py (path:/tmp/pip-gAUmNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:17 INFO - Running setup.py (path:/tmp/pip-Q7hRNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:17 INFO - Running setup.py (path:/tmp/pip-6usMCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:19 INFO - Downloading blessings-1.5.1.tar.gz 04:31:19 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 04:31:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:19 INFO - Installing collected packages: blessings 04:31:19 INFO - Running setup.py install for blessings 04:31:19 INFO - Successfully installed blessings 04:31:19 INFO - Cleaning up... 04:31:19 INFO - Return code: 0 04:31:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:20 INFO - Reading from file tmpfile_stdout 04:31:20 INFO - Current package versions: 04:31:20 INFO - argparse == 1.2.1 04:31:20 INFO - blessings == 1.5.1 04:31:20 INFO - blobuploader == 1.2.4 04:31:20 INFO - docopt == 0.6.1 04:31:20 INFO - manifestparser == 1.1 04:31:20 INFO - mozInstall == 1.12 04:31:20 INFO - mozcrash == 0.16 04:31:20 INFO - mozdebug == 0.1 04:31:20 INFO - mozdevice == 0.47 04:31:20 INFO - mozfile == 1.2 04:31:20 INFO - mozhttpd == 0.7 04:31:20 INFO - mozinfo == 0.9 04:31:20 INFO - mozleak == 0.1 04:31:20 INFO - mozlog == 3.1 04:31:20 INFO - moznetwork == 0.27 04:31:20 INFO - mozprocess == 0.22 04:31:20 INFO - mozprofile == 0.27 04:31:20 INFO - mozrunner == 6.11 04:31:20 INFO - mozscreenshot == 0.1 04:31:20 INFO - mozsystemmonitor == 0.0 04:31:20 INFO - moztest == 0.7 04:31:20 INFO - mozversion == 1.4 04:31:20 INFO - psutil == 3.1.1 04:31:20 INFO - requests == 1.2.3 04:31:20 INFO - wsgiref == 0.1.2 04:31:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:20 INFO - Using env: {'DISPLAY': ':0', 04:31:20 INFO - 'HOME': '/home/cltbld', 04:31:20 INFO - 'LANG': 'en_US.UTF-8', 04:31:20 INFO - 'LANGUAGE': 'en_US:en', 04:31:20 INFO - 'LOGNAME': 'cltbld', 04:31:20 INFO - 'MAIL': '/var/mail/cltbld', 04:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:20 INFO - 'MOZ_NO_REMOTE': '1', 04:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:20 INFO - 'NO_EM_RESTART': '1', 04:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:20 INFO - 'PWD': '/builds/slave/test', 04:31:20 INFO - 'SHELL': '/bin/bash', 04:31:20 INFO - 'SHLVL': '1', 04:31:20 INFO - 'TERM': 'linux', 04:31:20 INFO - 'TMOUT': '86400', 04:31:20 INFO - 'USER': 'cltbld', 04:31:20 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:20 INFO - '_': '/tools/buildbot/bin/python'} 04:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:20 INFO - Cleaning up... 04:31:20 INFO - Return code: 0 04:31:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:20 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:20 INFO - Using env: {'DISPLAY': ':0', 04:31:20 INFO - 'HOME': '/home/cltbld', 04:31:20 INFO - 'LANG': 'en_US.UTF-8', 04:31:20 INFO - 'LANGUAGE': 'en_US:en', 04:31:20 INFO - 'LOGNAME': 'cltbld', 04:31:20 INFO - 'MAIL': '/var/mail/cltbld', 04:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:20 INFO - 'MOZ_NO_REMOTE': '1', 04:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:20 INFO - 'NO_EM_RESTART': '1', 04:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:20 INFO - 'PWD': '/builds/slave/test', 04:31:20 INFO - 'SHELL': '/bin/bash', 04:31:20 INFO - 'SHLVL': '1', 04:31:20 INFO - 'TERM': 'linux', 04:31:20 INFO - 'TMOUT': '86400', 04:31:20 INFO - 'USER': 'cltbld', 04:31:20 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:20 INFO - '_': '/tools/buildbot/bin/python'} 04:31:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:20 INFO - Downloading/unpacking jsonschema 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 04:31:22 INFO - Downloading/unpacking functools32 (from jsonschema) 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:22 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:22 INFO - warning: no files found matching '*.txt' 04:31:22 INFO - no previously-included directories found matching 'build' 04:31:22 INFO - no previously-included directories found matching 'dist' 04:31:22 INFO - no previously-included directories found matching '.git*' 04:31:22 INFO - Installing collected packages: jsonschema, functools32 04:31:22 INFO - Running setup.py install for functools32 04:31:22 INFO - warning: no files found matching '*.txt' 04:31:22 INFO - no previously-included directories found matching 'build' 04:31:22 INFO - no previously-included directories found matching 'dist' 04:31:22 INFO - no previously-included directories found matching '.git*' 04:31:22 INFO - Successfully installed jsonschema functools32 04:31:22 INFO - Cleaning up... 04:31:22 INFO - Return code: 0 04:31:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:22 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 0x7f2262ad9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:31:22 INFO - Using env: {'DISPLAY': ':0', 04:31:22 INFO - 'HOME': '/home/cltbld', 04:31:22 INFO - 'LANG': 'en_US.UTF-8', 04:31:22 INFO - 'LANGUAGE': 'en_US:en', 04:31:22 INFO - 'LOGNAME': 'cltbld', 04:31:22 INFO - 'MAIL': '/var/mail/cltbld', 04:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:22 INFO - 'MOZ_NO_REMOTE': '1', 04:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:22 INFO - 'NO_EM_RESTART': '1', 04:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:22 INFO - 'PWD': '/builds/slave/test', 04:31:22 INFO - 'SHELL': '/bin/bash', 04:31:22 INFO - 'SHLVL': '1', 04:31:22 INFO - 'TERM': 'linux', 04:31:22 INFO - 'TMOUT': '86400', 04:31:22 INFO - 'USER': 'cltbld', 04:31:22 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:22 INFO - '_': '/tools/buildbot/bin/python'} 04:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:23 INFO - Downloading/unpacking flake8 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31: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 04:31:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:31:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 04:31:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:31:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 04:31:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 04:31:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:31:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:25 INFO - no previously-included directories found matching 'docs/_build' 04:31:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:31:25 INFO - Running setup.py install for pep8 04:31:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:31:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:31:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:31:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:31:25 INFO - no previously-included directories found matching 'docs/_build' 04:31:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:31:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:31:25 INFO - Cleaning up... 04:31:25 INFO - Return code: 0 04:31:25 INFO - Running post-action listener: _resource_record_post_action 04:31:25 INFO - Running post-action listener: _start_resource_monitoring 04:31:25 INFO - Starting resource monitoring. 04:31:25 INFO - ##### 04:31:25 INFO - ##### Running install step. 04:31:25 INFO - ##### 04:31:25 INFO - Running pre-action listener: _resource_record_pre_action 04:31:25 INFO - Running main action method: install 04:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:25 INFO - Reading from file tmpfile_stdout 04:31:25 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:25 INFO - Reading from file tmpfile_stdout 04:31:25 INFO - Output received: 04:31:25 INFO - Usage: mozinstall [options] installer 04:31:25 INFO - Options: 04:31:25 INFO - -h, --help show this help message and exit 04:31:25 INFO - -d DEST, --destination=DEST 04:31:25 INFO - Directory to install application into. [default: 04:31:25 INFO - "/builds/slave/test"] 04:31:25 INFO - --app=APP Application being installed. [default: firefox] 04:31:25 INFO - mkdir: /builds/slave/test/build/application 04:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:31:40 INFO - Reading from file tmpfile_stdout 04:31:40 INFO - Output received: 04:31:40 INFO - /builds/slave/test/build/application/firefox/firefox 04:31:40 INFO - Running post-action listener: _resource_record_post_action 04:31:40 INFO - ##### 04:31:40 INFO - ##### Running run-tests step. 04:31:40 INFO - ##### 04:31:40 INFO - Running pre-action listener: _resource_record_pre_action 04:31:40 INFO - Running main action method: run_tests 04:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:31:40 INFO - Python 2.7.3 04:31:40 INFO - Return code: 0 04:31:40 INFO - grabbing minidump binary from tooltool 04:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:31:40 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 0x11cb0b0>, '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 0x11cbfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11cc440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:31:40 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:31:40 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:31:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:31:40 INFO - Return code: 0 04:31:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:31:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:31:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:31:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:31:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:31:41 INFO - Return code: 0 04:31:41 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/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test/build 04:31:41 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/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 04:31:41 INFO - Using env: {'DISPLAY': ':0', 04:31:41 INFO - 'HOME': '/home/cltbld', 04:31:41 INFO - 'LANG': 'en_US.UTF-8', 04:31:41 INFO - 'LANGUAGE': 'en_US:en', 04:31:41 INFO - 'LOGNAME': 'cltbld', 04:31:41 INFO - 'MAIL': '/var/mail/cltbld', 04:31:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:31:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:41 INFO - 'MOZ_NO_REMOTE': '1', 04:31:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:41 INFO - 'NO_EM_RESTART': '1', 04:31:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:41 INFO - 'PWD': '/builds/slave/test', 04:31:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:31:41 INFO - 'SHELL': '/bin/bash', 04:31:41 INFO - 'SHLVL': '1', 04:31:41 INFO - 'TERM': 'linux', 04:31:41 INFO - 'TMOUT': '86400', 04:31:41 INFO - 'USER': 'cltbld', 04:31:41 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762', 04:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:41 INFO - '_': '/tools/buildbot/bin/python'} 04:31:41 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/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 04:31:41 INFO - mozversion INFO | application_buildid: 20151215030512 04:31:41 INFO - mozversion INFO | application_changeset: 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 04:31:41 INFO - mozversion INFO | application_display_name: Nightly 04:31:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:31:41 INFO - mozversion INFO | application_name: Firefox 04:31:41 INFO - mozversion INFO | application_remotingname: firefox 04:31:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:31:41 INFO - mozversion INFO | application_vendor: Mozilla 04:31:41 INFO - mozversion INFO | application_version: 46.0a1 04:31:41 INFO - mozversion INFO | platform_buildid: 20151215030512 04:31:41 INFO - mozversion INFO | platform_changeset: 7a22b7a21f27e5adc8d71f40d6035c2402e0a636 04:31:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:31:41 INFO - mozversion INFO | platform_version: 46.0a1 04:31:41 INFO - 2015-12-15 04:31:41,698 DEBUG : using testdate: 1450182701 04:31:41 INFO - 2015-12-15 04:31:41,698 DEBUG : actual date: 1450182701 04:31:41 INFO - 2015-12-15 04:31:41,707 INFO : starting webserver on 'localhost:33714' 04:31:41 INFO - 2015-12-15 04:31:41,708 INFO : Starting test suite talos-linux64-ix-068 04:31:41 INFO - 2015-12-15 04:31:41,708 INFO : Starting test dromaeo_css 04:31:41 INFO - 2015-12-15 04:31:41,709 DEBUG : operating with platform_type : linux_ 04:31:41 INFO - 2015-12-15 04:31:41,709 INFO : Initialising browser for dromaeo_css test... 04:31:41 INFO - 2015-12-15 04:31:41,724 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmW6V7t/profile http://localhost:33714/getInfo.html 04:31:45 INFO - 2015-12-15 04:31:45,684 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:31:45 INFO - 2015-12-15 04:31:45,684 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:31:45 INFO - 2015-12-15 04:31:45,684 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:31:45 INFO - 2015-12-15 04:31:45,684 DEBUG : BROWSER_OUTPUT: __metrics 04:31:45 INFO - 2015-12-15 04:31:45,833 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:31:45 INFO - 2015-12-15 04:31:45,897 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] 04:31:47 INFO - 2015-12-15 04:31:47,044 INFO : Browser initialized. 04:31:47 INFO - 2015-12-15 04:31:47,045 INFO : Running cycle 1/1 for dromaeo_css test... 04:31:47 INFO - 2015-12-15 04:31:47,045 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmW6V7t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:31:59 INFO - 2015-12-15 04:31:59,023 DEBUG : BROWSER_OUTPUT: RSS: Main: 142430208 04:31:59 INFO - 2015-12-15 04:31:59,023 DEBUG : BROWSER_OUTPUT: 04:32:50 INFO - 2015-12-15 04:32:50,160 DEBUG : BROWSER_OUTPUT: 1450182770155 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:35:01 INFO - 2015-12-15 04:35:01,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33714/tests/dromaeo/cssquery-ext.html) 04:35:02 INFO - 2015-12-15 04:35:02,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 230735872 04:35:02 INFO - 2015-12-15 04:35:02,850 DEBUG : BROWSER_OUTPUT: 04:38:05 INFO - 2015-12-15 04:38:05,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/dromaeo/cssquery-ext.html (next: http://localhost:33714/tests/dromaeo/cssquery-jquery.html) 04:38:05 INFO - 2015-12-15 04:38:05,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 218275840 04:38:05 INFO - 2015-12-15 04:38:05,954 DEBUG : BROWSER_OUTPUT: 04:41:08 INFO - 2015-12-15 04:41:08,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33714/tests/dromaeo/cssquery-mootools.html) 04:41:08 INFO - 2015-12-15 04:41:08,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 212201472 04:41:08 INFO - 2015-12-15 04:41:08,613 DEBUG : BROWSER_OUTPUT: 04:44:10 INFO - 2015-12-15 04:44:10,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33714/tests/dromaeo/cssquery-prototype.html) 04:44:11 INFO - 2015-12-15 04:44:11,084 DEBUG : BROWSER_OUTPUT: RSS: Main: 204107776 04:44:11 INFO - 2015-12-15 04:44:11,084 DEBUG : BROWSER_OUTPUT: 04:47:13 INFO - 2015-12-15 04:47:13,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33714/tests/dromaeo/cssquery-yui.html) 04:47:14 INFO - 2015-12-15 04:47:14,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 207872000 04:47:14 INFO - 2015-12-15 04:47:14,295 DEBUG : BROWSER_OUTPUT: 04:50:16 INFO - 2015-12-15 04:50:16,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/dromaeo/cssquery-yui.html (next: http://localhost:33714/tests/dromaeo/cssquery-dojo.html) 04:50:17 INFO - 2015-12-15 04:50:17,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 250392576 04:50:17 INFO - 2015-12-15 04:50:17,192 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,193 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:50:17 INFO - 2015-12-15 04:50:17,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:50:17 INFO - 2015-12-15 04:50:17,193 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:50:17 INFO - 2015-12-15 04:50:17,193 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:50:17 INFO - 2015-12-15 04:50:17,195 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2543.9364015899605;2634.222904243248;2647.033832651083;2653.3234025323563;2657.534931387007;4439.8446054388105;4567.383403240561;4577.793999270032;4645.047765208133;4649.9070018599605;4543.2276512992785;4593.356930029799;4631.444226692802;4651.906961860761;4677.812887484505;4210.410542524049;4225;4244.193603215394;4294.549072347405;4301.505326887401;4306.332518459643;4362;4383;4389.517153113155;4424.115176964604;4145.54399016108;4168.749875007509;4239.7668128252935;4326.459192600941;4383.583559561836;4313.309870420749;4316.287812510932;4318.676099292566;4342.392065110887;4348.239058164841;4264.914701705949;4280.507741609724;4281.422008028907;4295.226859165349;4332.393464914914;4480.484744254387;4612.769361531943;4621.306803979396;4622.722636641813;4679.227927391977;4848.806047758086;4919.631027672903;4934.235193545006;4943.752812359404;4968.031233909389;4959;4966.304717339575;4981.651284410093;5001.124803159469;5036.6726162799305;4446.6220371268155;4536.591706746342;4541.613962813198;4608.654350923694;4617.353570500132;5067;5143.254228136899;5163.741812909339;5166.380034395821;5210.21846722987;4868;4870.6103511718975;4872.049950259736;4873.122837889143;4917.041176970456;4752.049590081998;4881.975590122027;4882.902341953212;4968.950310496921;4977.65156439053;4767.332573439721;4981.227909674007;4997.325361076281;4998.075356059141;5041.621878359065;4894.706317620883;4898.461169271377;4899;4899.730514821719;4942.827001054946;4029.174019326031;4127.814248358831;4132.2561938851295;4132.359484279941;4177.874663760092;3574.5531808523933;3613.2954073955325;3665.7983810890655;3667.156553992597;3678.08047988003;4286.5284818669925;4290.678199135077;4292.205941900758;4310.31035034393;4329.631981281626;4791.089692958397;4942.481039490802;4947.455779864212;4948.8762780930765;4954.777035033432;4212.031232816408;4287.828486860491;4300.849470268526;4306.117245964632;4312.331588603772;4354.346847972766;4355;4358.150160718629;4377.387165796791;4396.824127034883;4662.906741865211;4667.043256132552;4667.6732628716345;4697.365855609449;4702.6708130431225;4803.711777293373;4899.314096026488;4914.066327397783;4916.70499770015;4919.237518184687;4736.550027747358;4737.952620473751;4738.455077665974;4741.786619602057;4783.449903261169;4915.852524424273;4916.778744956414;4918.631102667386;4934.037862616755;4964.67729597575;4781.258904869751;4899.975500122477;4903.53416425439;4967.155583550732;4977.776000079933;4760.262159365304;4836.443808962014;4838.2016967201425;4851.490593487633;4877.878053048702;4811.109944660249;4811.927821082617;4815.662903596854;4823.807047718052;4853.611711063177;4560.6123479503285;4608.28571571407;4617.676762626584;4727.976360118315;4776.283557466408;4772.952270477251;4835.637327200404;4859;4863.294822250825;4902.63230257725;4775.331453596569;4782.115308667908;4785.904281914272;4787.16224660676;4840.636952228527 04:50:17 INFO - 2015-12-15 04:50:17,196 DEBUG : BROWSER_OUTPUT: |1;ext.html;556.1213283012839;558.4304009909889;565.3611419096418;565.6323389796631;579.5971799599278;26526.336841578945;27021.91912323507;27058.864705676468;35624.10939726508;36113.81943090281;39202.41196382057;39502.20995580087;39726;39769.80115099427;39839;7893.4869233499785;8063.798405039892;8068.677252909876;8073.313768329699;8084.595770211496;7181.605011724379;7411.147718012417;7427.294407031323;7857.332126769232;10099.646512372068;10122.595096196143;10207;10215.182785377188;10225.386476811378;10230.283880128394;10081.294309398309;10131.949340253252;10160.187185025181;10181.898181018243;10190.89809101907;7032.4374050076385;7211.675474603656;7215.098112735908;10076.445795481246;10395.84406233907;36918.07704807374;37351.62648373509;37499.4375084374;37505.43741843875;37519.437208441894;2986.9850650746826;3013.3370658455106;3022.8186308821323;3025.4350736278316;3639.926221764559;28202.576961345596;28291.434171316458;28457.288567785763;28589;29065.709342906513;3166.841657917095;3173.730232930204;3246.6915643014113;3289.4572395554706;3299.96700032999;219983;221622;222276;222522.88738556366;222689;52605;53659;55184.72407637936;55452.72273638606;62850;56411.717941410854;56785.71607141938;56850;57237.71381143151;57255.42744572501;13902.304884755722;14037.438502459787;14074.2962851857;14081;14092.718145637235;10705.090067344207;10756.838647420294;10762.246642734934;10768.676939691823;10777.299475534222;19313.227470901005;19459.156956408984;19498.757373416705;19547.60904781925;19724.112414941363;7634.847303053908;7750.612469376509;7800.9219907801335;7843.411744119214;7863.685452581947;779.906411230656;822.786075620343;841.2765022081005;905.9547022648841;998.4857798233916;30233.69766302309;31587;31595.84202079021;31856.522152167738;32245;901.2879824938357;908.1644886704248;922.262190247799;959.6449313753816;985.8422652375585;13849.653758656113;13965.930170349084;13971.441142354191;14098.71802563943;14166.079204851652;318319;325222;325253;325457;327483;47745.76127119412;48285;48336;48336.7583162089;48440;1225.6261840138843;1233.3524899427873;1241.3420886929941;1243.8072098824696;1245.470674963137;23574.646380303966;29617.407651847272;30779;30982.69017309798;31118.08129139249;44191.779041105874;44847.55152448564;44874.326885096096;44877;44901;247195;247845;248048;248620;253253;33504.329913402085;34766.82616587002;37405;38969.2206155881;39867.80066099767;38273.61726382701;38370.80814595909;38577.80711096426;38717.41923871088;38885.80557097196;31390.529142063344;31974.291429816432;32945;38463.423048654855;39913.60086399215;33167.33665326632;35436.822815886786;39333.80333098316;39530.60469395269;39627;31761.364772703953;32446.188845279055;39017.609823901395;39177.216455671296;39432;30894.22764430907;35170.88485173084;35198.472022919166;35640.108997275274;35687.64312356947;23615.763842361357;23650.526989460457;23742.539215980076;23953.52092958166;24037.158699445434 04:50:17 INFO - 2015-12-15 04:50:17,197 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.11796385686364;334.2162628635851;334.4147741452458;336.22835592315636;338.6545723362171;12590.622281331553;13053.282069486175;14770.704585908275;15150.16674082925;15915.283812228463;8409.411341206118;9963.45201013944;10263.486825658705;14748.6312842179;15246.237688115605;4476.239039363308;4603.516630753773;4610.953890461103;4612.907741845161;4618.653600979923;3453.775504592206;3540.7698499597445;3541.1324225564645;3542.0967653248385;4807.591354734835;4935.703857768527;5113.386393632769;5113.437521872591;5142.640015198937;5144.511271429227;5054.9494505054845;5085.415177254626;5089.923651145235;5198.818041368571;5213.817516386908;5019.397672279313;5027.145385284511;5033.144365457881;5037.924431133536;5040.697558146487;10881.782364352668;14761.630959226106;14964.326605302787;19418;19426.611467770566;1642.2960485961355;1645.679092576948;1714.8971061736336;1721.311475409846;1833.3858157517247;8734.956325218396;8779.072071001248;9079.546022698905;9271.675491357837;11126.888731112665;1652.4419861024414;1690;1837.4579499047813;1858.9721154182698;1870.2238570993022;53704;53963;55311;55770.72114639441;55990.72004639992;9830.655927042519;9848.655297064712;9900.603975840886;9908.851367229498;9916.553755081039;12380.752384952251;12381.938090309492;12389.132760706663;12410.131290809737;12415.75168496625;6853;6890.31096890307;6903.585784852925;6916.723331066802;7016.7193312267955;6568.408843204039;6699.464042876656;6700.296468870698;6741.359570840762;6748.19021717397;4171.249175148502;4217.156568686275;4251.9787401062795;4254.404383386328;4264.808083636244;1617.5470868156935;1654.8427899349542;1689.3833750680913;1727.9913600431917;1771.3623095685543;769.3921801776534;799.2886331165267;811.0591713612182;829.5105887526388;829.7386323308139;14600.488982885761;15662.608434789221;15778.68442631164;15995.840041599668;16074.67850643004;796.5101462600459;832.7002279179491;836.9916300837035;870.4994628088874;915.6330884663088;8707.08575599553;8920.24177944882;8967.148120928501;9055.094490551024;9190.72427827153;478444;490455;493992;496735;522673;69714.65142674356;73093.634531827;74034.6298268516;75706.24293757102;76159.61920190364;1051.9789604207872;1053.0364716284514;1065.808154532176;1080.6974047266779;1095.5508241620896;13618.250996194907;14257.786133207803;14376.496822611158;14519.491817786327;14786.334614942569;30169.396612068074;30196.698033019387;30526.694733053275;30937.535936960514;34651.13372165716;38106.428403573416;38696.613033870424;39329.60670393259;39873.2025359497;40523;8064.274215320649;8505.574721264036;8679.435836670596;8886.688965886164;8900.287976961697;10285;12091.75816483683;15317.080975141527;15341.156236407105;15810.841891580936;9803.950980245338;10384.221183411426;13387.665308366979;13873.930630346784;13925.72148557003;10244.743881403025;13248.138870973356;13365.86634133685;13442.193468391928;13563.457461701422;14263.857361426253;14300.141991480545;14623.04950178235;14834.777478337617;14854.405823766929;8833.602487888189;8898.332625053277;9024.458532488072;9195.126462986273;9213;13929.860701393261;13939;14135.293235337986;14427.35076921562;14604.92697536548 04:50:17 INFO - 2015-12-15 04:50:17,199 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1439.0574173916089;1635.1660653066933;1681.5039563328824;1700.4133573916995;1709.581152617609;5819.854503637411;6702.396784289413;6936.6531673416375;6938.444924406048;6951.4438844892475;6747.257801641827;6889.6555172241315;6903.654817259142;6914.204866440361;6923.273056329089;1715.6568686262797;1749.6763098826693;1914.6457905287532;1948.4544327588228;1952.6094781043778;2005.4084045206625;2010.909509072088;2012.8087831655969;2013.9798602013939;2015.7379540659767;1974.9605007899904;1979.613975274822;2045.1308194017558;2045.8158765711082;2049.549099198174;1973.7927517610588;1977.1399441243034;2001.5996800639857;2001.609686111209;2041.1121162294448;2019.939401817933;2046.5395286060666;2051.8768873867616;2053.5482193917314;2056.259746491262;6730.7307707692125;6809.693563789592;6859.416949559293;6886.173659160882;6890.793276201722;3840.9039774005873;3886.0867696091395;3888.863889763845;3898.8498392973856;3902.356111241642;2448.179859746969;2577.1624222127884;2598.8050896182863;2608.2175347395896;2616.9345766355805;809.8299357135008;827.0984626756864;852.2840813716446;855.7047818502607;859.1236938322938;8744.956275218647;8838.072002439716;8895.377323587352;8900.198982091579;8904.51025193614;3603.5135256740527;3653.598104208535;3667.1382225177063;3676.9080772980888;3730.6828919542145;7760.650770715219;7761.805954851174;7765.650545725343;7778.572178530122;7785.688572457151;4015.578364271768;4024.6176613221696;4025.376066709665;4027.5368332641533;4032.3951407288555;3661.9633803662155;3664.0656632558525;3667.4132138857653;3667.7615954962844;3668.816559172031;2793.6507936507937;2813.620161278201;3170.9048728538182;3223.8226897520394;3291.144302481372;1038.0864838941684;1072.463768115942;1077.3105212663745;1084.5011294804322;1085.4898197846999;904.5296445848122;906.2025417632441;909.4952301472614;951.9956445949451;1141.57191053355;6267.435930766253;6286.371362863677;6289.182406287154;6316.936830631635;6321.810345689637;1044.5821671331375;1052.8210204265292;1055.8152323343384;1057.545255540125;1078.9136869050458;4989.151844186497;4994.700317980933;5073.315102461194;5078.958813443309;5095.439501654815;7730.458867879307;8020.238077382639;8062.750273707585;8107.756767296873;8137.715179968673;7981.321587665114;7981.483518131537;8016.398770092266;8041.276285134366;8050.23522765348;6339.334369891095;6401.3278605746655;6461.709223084972;6487.805365839033;6505.316941721051;6002.549808764447;6018.638881667114;6043.969780151071;6069.4840938518955;6075.0279955208725;7212.855742885218;7242.348188663045;7271.563706177435;7315.926840731738;7405.518641288299;6975.511714179958;7154.713811447484;7262.782116536512;7524.247575242432;7528.548287102792;6147.969260153671;6216.844578885383;6225.564210505221;6231;6234.625922444668;5506.146547285177;5570.24801651788;6187.597806142587;6218.626882387071;6576.868462630816;6119.84700382494;6191.9690401547705;6256.530760192913;6268.247810262797;6371.776987805404;6029.638221706711;6048.939510604838;6189.412005859436;6195.690215489118;6207;6191.318954914866;6211.068339749074;6211.192544969125;6260.780872669435;6306.495480361652;5675.460831221028;5721.485066344049;5729.197912292199;5744.798932037359;5747.281589801275;5813.331466881194;5828.417158284137;5843.211166492469;5843.883122337445;5849.707514624337 04:50:17 INFO - 2015-12-15 04:50:17,200 DEBUG : BROWSER_OUTPUT: |4;prototype.html;291.3241280229867;300.37821709062234;301.67871217153737;304.55991092870784;305.30695321619936;5195.740212989354;5200.557952574031;5301.734913254336;5347.973260133704;5351.598630102739;5177.534021938025;5255.710935898524;5264.684118952866;5266.5786737061035;5281.128613778731;3815.2068527791894;4042.6361627453525;4044.939325910114;4046.9797651011704;4053.8378464861444;3875.8255878485393;3916.4321173429835;3916.471276377681;3916.5495967963766;3917.6669983051474;3916.784576848272;3946.427767973642;3975.0658595230097;3996.2806694794926;3999.320115580358;3982.3030969580495;3984.322665146932;3989;3994.1612261425134;4002.699797515169;3304.520844477537;3381.780184288038;3410.931781364384;3496.1958749487508;3508.491268766015;4980.800767969277;4998.925016124761;5001.89996200074;5026.371703537058;5029.346184995964;4570.680052396334;4573.611243044312;4578.5650363215445;4579.267317229261;4583.8166473341025;5384.730763461811;5399.757010934517;5417.620766546304;5424.647397919122;5460.808871689512;3730.962690373116;3794.5636251831115;3797.145642230476;3811.7712937223855;3813.180166264239;5692.288463942007;5774.942250577483;5776.855578610526;5776.971115144397;5784.479396854304;3892.824822882977;3893.1629699614155;3893.6301051400073;3894.4742459768136;3897.5322961244265;3951.249262640089;3955.64399204073;3956.347202711578;3957.2085582883537;3957.762534247954;4459.152760975404;4536.432945881765;4545.818167273338;4560.726356418625;4563.703359281636;5481.451854814487;5486.561075113981;5488.588355873326;5491.560675145979;5495.670259784426;1381.5233744358181;1401.1593044173414;1401.6495876030992;1401.9088759230822;1409.7391982483273;912.6760000199966;936.765808547863;942.8491441369348;943.8678584998106;955.9091886270793;4837.105135549935;4840.83057093;4848.224284114524;4856.053069651454;4856.344393506902;5645.379008309083;5672.319321681424;5677.886442271131;5681.488666019995;5701.486866182064;4863.781129849165;4868.732219727949;4870;4870.512948705172;4877.219644856806;2993.580898674187;3049.8932537361084;3069.938601227963;3075.4617941860083;3076.630804303498;5231.921521177185;5322.946770532322;5383.542398896059;5389.380221274525;5395.919061214085;5907.49786268172;5912.201852749824;5917.053271476543;5923.555733320019;5934.109883517421;5437.34751829783;5445.564354851682;5448.155535891943;5449.482299181572;5450.509454149145;5641.210230567806;5647.435256474319;5750.942490575041;5751;5762.654240745569;5596.496315331639;5598.440155984532;5602.047651899268;5613.186088017296;5620.353659329229;5431.34823821144;5437.673739575638;5438.211459338295;5445.40100588927;5448.673079615236;3926.234384295035;3930.0764320384114;3930.0960779020415;3931.488906442144;3934.9213015740097;5608.186812912023;5744.396838331915;5750.396208398058;5750.942490575041;5752.108423194411;5521.668699878021;5538.47384498472;5540.612157148961;5540.667559946416;5551.2228288040515;5530.336359636869;5530.585206109477;5536.7785288588;5537.501624853782;5539;5271.182966640177;5407.486288802557;5413.404525502113;5418.83743487696;5421.945780542144;5561;5564;5564.666120032811;5566.22072909801;5576.191452239484;5432.429594892479;5435.918461223006;5439.48324909133;5439.755211015435;5442.455754424526 04:50:17 INFO - 2015-12-15 04:50:17,201 DEBUG : BROWSER_OUTPUT: |5;yui.html;655.2988302516308;699.3425581372148;726.2519604807048;789.727543997321;794.749653859034;11707.473163707633;11774.470148843302;11820.40897955101;11859.05127589793;11864.881351186486;11640;11800.173987820855;11815.054795616352;11822.704432389195;11823.881761182385;632.3549979021418;640.3020707428901;789.9526028438298;799.6481548118838;815.8123631564744;792.809725665839;794.6781553470854;795.7334293011819;795.7453614843253;798.2097723253966;652.533438591407;835.4235577451539;840.4327079221532;841.1168273313027;841.474078700812;653.5980372071166;820.6225136437216;838.5471845203583;838.6184286149787;839.4837175137246;618.6319140111672;621.1862460177138;622.2129006806393;622.240866143309;625.0592857749059;11686.415679216005;11813.822792658117;11820.23168494045;11827.112966527546;11839.526418943233;10774.622888198875;11436.71408214793;11476.368799716012;11476.885231147666;11666.300021998708;9157.313201509913;9272.119148680864;9276.489793061379;9415.670451534232;9416.246700264031;3169.6354919184128;3211.8715251389917;3238.17426556229;3238.5627940228005;3246.594175728034;38997.610023899964;39100.41349379761;39112.21775564501;39211.8039409804;39217.411738823655;9272.629094836131;9313.53432328381;9328;9514.238860891111;9545;16907.309269072994;16933.915330423515;16944.40694575684;16951.321947122222;16952.067636280124;6347.1114044033875;6588.275289718127;6590.406863382319;6688.163979502562;6769.356911093439;3457.6888080072913;3480.9547139371944;3525.524054252643;3537.398642230827;3605.2789442111157;2419.4556224849266;2450.130203777669;2453.092355828355;2454.0551887523075;2456.7788898999174;428.4601402233146;438.0516182464991;442.4911351945224;445.11866504321625;445.59228306100204;432.75765571280186;515.0265997265097;523.4712939930621;564.4355644355644;590.3653572409677;7301.59841208728;7459.738909138154;7590.924090759132;7716.382689384835;7742.380609551223;400.991980160401;483.8209862350953;498.82042464712674;560.1569637695243;568.4656422962402;3501.2647344057523;3813.8665146720286;3831.1954489557506;3860.8069596520063;3875.3605655067163;43037.13925721468;43043.56956430396;43180.3522947156;43785.343219851726;44037;45272.54727452749;45524.54475455203;45730.31404528935;45792.313115303295;46561.30158047632;40503;41363.7931810345;41538.792306038275;41645;41984.79007604942;7602.657880395285;7764.534127952341;7858.842823143391;8060.637271322687;8161.755147345589;30442.938099822455;31175.53236701406;31177.84411078021;31387.686123138476;31721.5241771369;40160.799196003834;40223.396649050876;40224.597754023256;41022.79488602538;41161;9634.518274086407;9651.517424128906;10015.39907605546;10229.546616881227;10311.639092632022;11276.210665253353;11373.488193031168;11558.826617600575;11667.183297169457;11831.822522661994;10411.891950757095;10741.355518668905;11001.339919604849;11086.556537738723;11489.195756297313;9583.472908990072;9718.514074296116;9738.707838764849;10485.21360897951;10597.947010265209;8785.341099417697;9251.722448326562;9808.901910981085;9868.753281167741;10276.383416995004;9267.490288034223;9324.160825525736;9408.717738467856;9422.95288523553;9602.183814375856;8695.434796738191;9186.356955013352;9297.907020929975;9312.521221563138;9612.711618651452 04:50:17 INFO - 2015-12-15 04:50:17,201 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:50:17 INFO - 2015-12-15 04:50:17,201 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:50:17 INFO - 2015-12-15 04:50:17,201 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,807 04:50:17 INFO - 2015-12-15 04:50:17,201 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:50:17 INFO - 2015-12-15 04:50:17,201 DEBUG : BROWSER_OUTPUT: __startTimestamp1450183817192__endTimestamp 04:50:17 INFO - 2015-12-15 04:50:17,202 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,202 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:50:17 INFO - 2015-12-15 04:50:17,202 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:50:17 INFO - 2015-12-15 04:50:17,202 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,202 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4573.16 Median:4702.67 stddev:474.09 (10.1%) stddev-sans-first:448.02 04:50:17 INFO - 2015-12-15 04:50:17,203 DEBUG : BROWSER_OUTPUT: Values: 2543.9 2634.2 2647.0 2653.3 2657.5 4439.8 4567.4 4577.8 4645.0 4649.9 4543.2 4593.4 4631.4 4651.9 4677.8 4210.4 4225.0 4244.2 4294.5 4301.5 4306.3 4362.0 4383.0 4389.5 4424.1 4145.5 4168.7 4239.8 4326.5 4383.6 4313.3 4316.3 4318.7 4342.4 4348.2 4264.9 4280.5 4281.4 4295.2 4332.4 4480.5 4612.8 4621.3 4622.7 4679.2 4848.8 4919.6 4934.2 4943.8 4968.0 4959.0 4966.3 4981.7 5001.1 5036.7 4446.6 4536.6 4541.6 4608.7 4617.4 5067.0 5143.3 5163.7 5166.4 5210.2 4868.0 4870.6 4872.0 4873.1 4917.0 4752.0 4882.0 4882.9 4969.0 4977.7 4767.3 4981.2 4997.3 4998.1 5041.6 4894.7 4898.5 4899.0 4899.7 4942.8 4029.2 4127.8 4132.3 4132.4 4177.9 3574.6 3613.3 3665.8 3667.2 3678.1 4286.5 4290.7 4292.2 4310.3 4329.6 4791.1 4942.5 4947.5 4948.9 4954.8 4212.0 4287.8 4300.8 4306.1 4312.3 4354.3 4355.0 4358.2 4377.4 4396.8 4662.9 4667.0 4667.7 4697.4 4702.7 4803.7 4899.3 4914.1 4916.7 4919.2 4736.6 4738.0 4738.5 4741.8 4783.4 4915.9 4916.8 4918.6 4934.0 4964.7 4781.3 4900.0 4903.5 4967.2 4977.8 4760.3 4836.4 4838.2 4851.5 4877.9 4811.1 4811.9 4815.7 4823.8 4853.6 4560.6 4608.3 4617.7 4728.0 4776.3 4773.0 4835.6 4859.0 4863.3 4902.6 4775.3 4782.1 4785.9 4787.2 4840.6 04:50:17 INFO - 2015-12-15 04:50:17,203 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,203 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43361.26 Median:18233.65 stddev:70114.60 (384.5%) stddev-sans-first:70237.63 04:50:17 INFO - 2015-12-15 04:50:17,203 DEBUG : BROWSER_OUTPUT: Values: 556.1 558.4 565.4 565.6 579.6 26526.3 27021.9 27058.9 35624.1 36113.8 39202.4 39502.2 39726.0 39769.8 39839.0 7893.5 8063.8 8068.7 8073.3 8084.6 7181.6 7411.1 7427.3 7857.3 10099.6 10122.6 10207.0 10215.2 10225.4 10230.3 10081.3 10131.9 10160.2 10181.9 10190.9 7032.4 7211.7 7215.1 10076.4 10395.8 36918.1 37351.6 37499.4 37505.4 37519.4 2987.0 3013.3 3022.8 3025.4 3639.9 28202.6 28291.4 28457.3 28589.0 29065.7 3166.8 3173.7 3246.7 3289.5 3300.0 219983.0 221622.0 222276.0 222522.9 222689.0 52605.0 53659.0 55184.7 55452.7 62850.0 56411.7 56785.7 56850.0 57237.7 57255.4 13902.3 14037.4 14074.3 14081.0 14092.7 10705.1 10756.8 10762.2 10768.7 10777.3 19313.2 19459.2 19498.8 19547.6 19724.1 7634.8 7750.6 7800.9 7843.4 7863.7 779.9 822.8 841.3 906.0 998.5 30233.7 31587.0 31595.8 31856.5 32245.0 901.3 908.2 922.3 959.6 985.8 13849.7 13965.9 13971.4 14098.7 14166.1 318319.0 325222.0 325253.0 325457.0 327483.0 47745.8 48285.0 48336.0 48336.8 48440.0 1225.6 1233.4 1241.3 1243.8 1245.5 23574.6 29617.4 30779.0 30982.7 31118.1 44191.8 44847.6 44874.3 44877.0 44901.0 247195.0 247845.0 248048.0 248620.0 253253.0 33504.3 34766.8 37405.0 38969.2 39867.8 38273.6 38370.8 38577.8 38717.4 38885.8 31390.5 31974.3 32945.0 38463.4 39913.6 33167.3 35436.8 39333.8 39530.6 39627.0 31761.4 32446.2 39017.6 39177.2 39432.0 30894.2 35170.9 35198.5 35640.1 35687.6 23615.8 23650.5 23742.5 23953.5 24037.2 04:50:17 INFO - 2015-12-15 04:50:17,203 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,203 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26199.45 Median:40198.10 stddev:81152.02 (201.9%) stddev-sans-first:81356.42 04:50:17 INFO - 2015-12-15 04:50:17,205 DEBUG : BROWSER_OUTPUT: Values: 329.1 334.2 334.4 336.2 338.7 12590.6 13053.3 14770.7 15150.2 15915.3 8409.4 9963.5 10263.5 14748.6 15246.2 4476.2 4603.5 4611.0 4612.9 4618.7 3453.8 3540.8 3541.1 3542.1 4807.6 4935.7 5113.4 5113.4 5142.6 5144.5 5054.9 5085.4 5089.9 5198.8 5213.8 5019.4 5027.1 5033.1 5037.9 5040.7 10881.8 14761.6 14964.3 19418.0 19426.6 1642.3 1645.7 1714.9 1721.3 1833.4 8735.0 8779.1 9079.5 9271.7 11126.9 1652.4 1690.0 1837.5 1859.0 1870.2 53704.0 53963.0 55311.0 55770.7 55990.7 9830.7 9848.7 9900.6 9908.9 9916.6 12380.8 12381.9 12389.1 12410.1 12415.8 6853.0 6890.3 6903.6 6916.7 7016.7 6568.4 6699.5 6700.3 6741.4 6748.2 4171.2 4217.2 4252.0 4254.4 4264.8 1617.5 1654.8 1689.4 1728.0 1771.4 769.4 799.3 811.1 829.5 829.7 14600.5 15662.6 15778.7 15995.8 16074.7 796.5 832.7 837.0 870.5 915.6 8707.1 8920.2 8967.1 9055.1 9190.7 478444.0 490455.0 493992.0 496735.0 522673.0 69714.7 73093.6 74034.6 75706.2 76159.6 1052.0 1053.0 1065.8 1080.7 1095.6 13618.3 14257.8 14376.5 14519.5 14786.3 30169.4 30196.7 30526.7 30937.5 34651.1 38106.4 38696.6 39329.6 39873.2 40523.0 8064.3 8505.6 8679.4 8886.7 8900.3 10285.0 12091.8 15317.1 15341.2 15810.8 9804.0 10384.2 13387.7 13873.9 13925.7 10244.7 13248.1 13365.9 13442.2 13563.5 14263.9 14300.1 14623.0 14834.8 14854.4 8833.6 8898.3 9024.5 9195.1 9213.0 13929.9 13939.0 14135.3 14427.4 14604.9 04:50:17 INFO - 2015-12-15 04:50:17,205 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,205 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4727.72 Median:6024.14 stddev:2412.84 (40.1%) stddev-sans-first:2406.94 04:50:17 INFO - 2015-12-15 04:50:17,205 DEBUG : BROWSER_OUTPUT: Values: 1439.1 1635.2 1681.5 1700.4 1709.6 5819.9 6702.4 6936.7 6938.4 6951.4 6747.3 6889.7 6903.7 6914.2 6923.3 1715.7 1749.7 1914.6 1948.5 1952.6 2005.4 2010.9 2012.8 2014.0 2015.7 1975.0 1979.6 2045.1 2045.8 2049.5 1973.8 1977.1 2001.6 2001.6 2041.1 2019.9 2046.5 2051.9 2053.5 2056.3 6730.7 6809.7 6859.4 6886.2 6890.8 3840.9 3886.1 3888.9 3898.8 3902.4 2448.2 2577.2 2598.8 2608.2 2616.9 809.8 827.1 852.3 855.7 859.1 8745.0 8838.1 8895.4 8900.2 8904.5 3603.5 3653.6 3667.1 3676.9 3730.7 7760.7 7761.8 7765.7 7778.6 7785.7 4015.6 4024.6 4025.4 4027.5 4032.4 3662.0 3664.1 3667.4 3667.8 3668.8 2793.7 2813.6 3170.9 3223.8 3291.1 1038.1 1072.5 1077.3 1084.5 1085.5 904.5 906.2 909.5 952.0 1141.6 6267.4 6286.4 6289.2 6316.9 6321.8 1044.6 1052.8 1055.8 1057.5 1078.9 4989.2 4994.7 5073.3 5079.0 5095.4 7730.5 8020.2 8062.8 8107.8 8137.7 7981.3 7981.5 8016.4 8041.3 8050.2 6339.3 6401.3 6461.7 6487.8 6505.3 6002.5 6018.6 6044.0 6069.5 6075.0 7212.9 7242.3 7271.6 7315.9 7405.5 6975.5 7154.7 7262.8 7524.2 7528.5 6148.0 6216.8 6225.6 6231.0 6234.6 5506.1 5570.2 6187.6 6218.6 6576.9 6119.8 6192.0 6256.5 6268.2 6371.8 6029.6 6048.9 6189.4 6195.7 6207.0 6191.3 6211.1 6211.2 6260.8 6306.5 5675.5 5721.5 5729.2 5744.8 5747.3 5813.3 5828.4 5843.2 5843.9 5849.7 04:50:17 INFO - 2015-12-15 04:50:17,205 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,205 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4553.00 Median:5265.63 stddev:1356.67 (25.8%) stddev-sans-first:1322.23 04:50:17 INFO - 2015-12-15 04:50:17,206 DEBUG : BROWSER_OUTPUT: Values: 291.3 300.4 301.7 304.6 305.3 5195.7 5200.6 5301.7 5348.0 5351.6 5177.5 5255.7 5264.7 5266.6 5281.1 3815.2 4042.6 4044.9 4047.0 4053.8 3875.8 3916.4 3916.5 3916.5 3917.7 3916.8 3946.4 3975.1 3996.3 3999.3 3982.3 3984.3 3989.0 3994.2 4002.7 3304.5 3381.8 3410.9 3496.2 3508.5 4980.8 4998.9 5001.9 5026.4 5029.3 4570.7 4573.6 4578.6 4579.3 4583.8 5384.7 5399.8 5417.6 5424.6 5460.8 3731.0 3794.6 3797.1 3811.8 3813.2 5692.3 5774.9 5776.9 5777.0 5784.5 3892.8 3893.2 3893.6 3894.5 3897.5 3951.2 3955.6 3956.3 3957.2 3957.8 4459.2 4536.4 4545.8 4560.7 4563.7 5481.5 5486.6 5488.6 5491.6 5495.7 1381.5 1401.2 1401.6 1401.9 1409.7 912.7 936.8 942.8 943.9 955.9 4837.1 4840.8 4848.2 4856.1 4856.3 5645.4 5672.3 5677.9 5681.5 5701.5 4863.8 4868.7 4870.0 4870.5 4877.2 2993.6 3049.9 3069.9 3075.5 3076.6 5231.9 5322.9 5383.5 5389.4 5395.9 5907.5 5912.2 5917.1 5923.6 5934.1 5437.3 5445.6 5448.2 5449.5 5450.5 5641.2 5647.4 5750.9 5751.0 5762.7 5596.5 5598.4 5602.0 5613.2 5620.4 5431.3 5437.7 5438.2 5445.4 5448.7 3926.2 3930.1 3930.1 3931.5 3934.9 5608.2 5744.4 5750.4 5750.9 5752.1 5521.7 5538.5 5540.6 5540.7 5551.2 5530.3 5530.6 5536.8 5537.5 5539.0 5271.2 5407.5 5413.4 5418.8 5421.9 5561.0 5564.0 5564.7 5566.2 5576.2 5432.4 5435.9 5439.5 5439.8 5442.5 04:50:17 INFO - 2015-12-15 04:50:17,206 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,206 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12098.06 Median:443.80 stddev:13488.16 (3039.2%) stddev-sans-first:13498.62 04:50:17 INFO - 2015-12-15 04:50:17,207 DEBUG : BROWSER_OUTPUT: Values: 655.3 699.3 726.3 789.7 794.7 11707.5 11774.5 11820.4 11859.1 11864.9 11640.0 11800.2 11815.1 11822.7 11823.9 632.4 640.3 790.0 799.6 815.8 792.8 794.7 795.7 795.7 798.2 652.5 835.4 840.4 841.1 841.5 653.6 820.6 838.5 838.6 839.5 618.6 621.2 622.2 622.2 625.1 11686.4 11813.8 11820.2 11827.1 11839.5 10774.6 11436.7 11476.4 11476.9 11666.3 9157.3 9272.1 9276.5 9415.7 9416.2 3169.6 3211.9 3238.2 3238.6 3246.6 38997.6 39100.4 39112.2 39211.8 39217.4 9272.6 9313.5 9328.0 9514.2 9545.0 16907.3 16933.9 16944.4 16951.3 16952.1 6347.1 6588.3 6590.4 6688.2 6769.4 3457.7 3481.0 3525.5 3537.4 3605.3 2419.5 2450.1 2453.1 2454.1 2456.8 428.5 438.1 442.5 445.1 445.6 432.8 515.0 523.5 564.4 590.4 7301.6 7459.7 7590.9 7716.4 7742.4 401.0 483.8 498.8 560.2 568.5 3501.3 3813.9 3831.2 3860.8 3875.4 43037.1 43043.6 43180.4 43785.3 44037.0 45272.5 45524.5 45730.3 45792.3 46561.3 40503.0 41363.8 41538.8 41645.0 41984.8 7602.7 7764.5 7858.8 8060.6 8161.8 30442.9 31175.5 31177.8 31387.7 31721.5 40160.8 40223.4 40224.6 41022.8 41161.0 9634.5 9651.5 10015.4 10229.5 10311.6 11276.2 11373.5 11558.8 11667.2 11831.8 10411.9 10741.4 11001.3 11086.6 11489.2 9583.5 9718.5 9738.7 10485.2 10597.9 8785.3 9251.7 9808.9 9868.8 10276.4 9267.5 9324.2 9408.7 9423.0 9602.2 8695.4 9186.4 9297.9 9312.5 9612.7 04:50:17 INFO - 2015-12-15 04:50:17,207 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:50:17 INFO - 2015-12-15 04:50:17,207 DEBUG : BROWSER_OUTPUT: 04:50:17 INFO - 2015-12-15 04:50:17,915 INFO : Browser exited with error code: 0 04:50:17 INFO - 2015-12-15 04:50:17,933 INFO : Completed test dromaeo_css (00:18:36) 04:50:17 INFO - 2015-12-15 04:50:17,933 INFO : Starting test kraken 04:50:17 INFO - 2015-12-15 04:50:17,933 DEBUG : operating with platform_type : linux_ 04:50:17 INFO - 2015-12-15 04:50:17,933 INFO : Initialising browser for kraken test... 04:50:17 INFO - 2015-12-15 04:50:17,939 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVkKzuX/profile http://localhost:33714/getInfo.html 04:50:22 INFO - 2015-12-15 04:50:22,358 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:50:22 INFO - 2015-12-15 04:50:22,358 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:50:22 INFO - 2015-12-15 04:50:22,358 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:50:22 INFO - 2015-12-15 04:50:22,358 DEBUG : BROWSER_OUTPUT: __metrics 04:50:22 INFO - 2015-12-15 04:50:22,419 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:50:22 INFO - 2015-12-15 04:50:22,495 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] 04:50:23 INFO - 2015-12-15 04:50:23,359 INFO : Browser initialized. 04:50:23 INFO - 2015-12-15 04:50:23,360 INFO : Running cycle 1/1 for kraken test... 04:50:23 INFO - 2015-12-15 04:50:23,360 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVkKzuX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:50:35 INFO - 2015-12-15 04:50:35,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 142413824 04:50:35 INFO - 2015-12-15 04:50:35,295 DEBUG : BROWSER_OUTPUT: 04:50:37 INFO - 2015-12-15 04:50:37,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33714/tests/kraken/driver.html?testName=audio-beat-detection) 04:50:38 INFO - 2015-12-15 04:50:38,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 179204096 04:50:38 INFO - 2015-12-15 04:50:38,533 DEBUG : BROWSER_OUTPUT: 04:50:41 INFO - 2015-12-15 04:50:41,255 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33714/tests/kraken/driver.html?testName=audio-dft) 04:50:41 INFO - 2015-12-15 04:50:41,837 DEBUG : BROWSER_OUTPUT: RSS: Main: 166756352 04:50:41 INFO - 2015-12-15 04:50:41,837 DEBUG : BROWSER_OUTPUT: 04:50:44 INFO - 2015-12-15 04:50:44,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33714/tests/kraken/driver.html?testName=audio-fft) 04:50:45 INFO - 2015-12-15 04:50:45,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 153522176 04:50:45 INFO - 2015-12-15 04:50:45,423 DEBUG : BROWSER_OUTPUT: 04:50:47 INFO - 2015-12-15 04:50:47,521 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33714/tests/kraken/driver.html?testName=audio-oscillator) 04:50:48 INFO - 2015-12-15 04:50:48,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 155721728 04:50:48 INFO - 2015-12-15 04:50:48,094 DEBUG : BROWSER_OUTPUT: 04:50:50 INFO - 2015-12-15 04:50:50,373 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:50:50 INFO - 2015-12-15 04:50:50,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 158052352 04:50:50 INFO - 2015-12-15 04:50:50,942 DEBUG : BROWSER_OUTPUT: 04:50:53 INFO - 2015-12-15 04:50:53,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33714/tests/kraken/driver.html?testName=imaging-darkroom) 04:50:54 INFO - 2015-12-15 04:50:54,508 DEBUG : BROWSER_OUTPUT: RSS: Main: 157446144 04:50:54 INFO - 2015-12-15 04:50:54,508 DEBUG : BROWSER_OUTPUT: 04:50:57 INFO - 2015-12-15 04:50:57,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33714/tests/kraken/driver.html?testName=imaging-desaturate) 04:50:58 INFO - 2015-12-15 04:50:58,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 158523392 04:50:58 INFO - 2015-12-15 04:50:58,553 DEBUG : BROWSER_OUTPUT: 04:51:01 INFO - 2015-12-15 04:51:01,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33714/tests/kraken/driver.html?testName=json-parse-financial) 04:51:02 INFO - 2015-12-15 04:51:02,025 DEBUG : BROWSER_OUTPUT: RSS: Main: 158154752 04:51:02 INFO - 2015-12-15 04:51:02,025 DEBUG : BROWSER_OUTPUT: 04:51:03 INFO - 2015-12-15 04:51:03,860 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:04 INFO - 2015-12-15 04:51:04,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 165056512 04:51:04 INFO - 2015-12-15 04:51:04,421 DEBUG : BROWSER_OUTPUT: 04:51:06 INFO - 2015-12-15 04:51:06,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:06 INFO - 2015-12-15 04:51:06,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 166043648 04:51:06 INFO - 2015-12-15 04:51:06,906 DEBUG : BROWSER_OUTPUT: 04:51:09 INFO - 2015-12-15 04:51:09,060 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:09 INFO - 2015-12-15 04:51:09,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 178360320 04:51:09 INFO - 2015-12-15 04:51:09,646 DEBUG : BROWSER_OUTPUT: 04:51:12 INFO - 2015-12-15 04:51:12,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:12 INFO - 2015-12-15 04:51:12,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 183488512 04:51:12 INFO - 2015-12-15 04:51:12,802 DEBUG : BROWSER_OUTPUT: 04:51:15 INFO - 2015-12-15 04:51:15,438 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:16 INFO - 2015-12-15 04:51:16,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 179945472 04:51:16 INFO - 2015-12-15 04:51:16,019 DEBUG : BROWSER_OUTPUT: 04:51:17 INFO - 2015-12-15 04:51:17,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33714/tests/kraken/driver.html?testName=ai-astar) 04:51:18 INFO - 2015-12-15 04:51:18,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 239689728 04:51:18 INFO - 2015-12-15 04:51:18,039 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,039 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:51:18 INFO - 2015-12-15 04:51:18,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:51:18 INFO - 2015-12-15 04:51:18,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:51:18 INFO - 2015-12-15 04:51:18,039 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;109;112;112;115;103;112;112;111 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;130;155;170;143;156;155;136;174;132 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;163;161;161;162;164;162;162 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;90;103;75;74;73;119;95;73 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;133;95;95;96;129;94;95;139 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;109;109;109;109;110;109;110;110;109 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;148;149;149;149;149;149;149;149;147 04:51:18 INFO - 2015-12-15 04:51:18,040 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;96;96;96;95 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;76;74;76;74;76;78;84;72;72 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;69;69;69;68;69;68 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;85;84;85;85;85;84;86;84 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;120;121;121;135;128;124;120;135;136 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;138;150;152;155;140;151;152;149;142 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;70;70;72;70;70;69;72;70 04:51:18 INFO - 2015-12-15 04:51:18,041 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:51:18 INFO - 2015-12-15 04:51:18,042 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:51:18 INFO - 2015-12-15 04:51:18,042 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 04:51:18 INFO - 2015-12-15 04:51:18,042 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:51:18 INFO - 2015-12-15 04:51:18,042 DEBUG : BROWSER_OUTPUT: __startTimestamp1450183878037__endTimestamp 04:51:18 INFO - 2015-12-15 04:51:18,042 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:3.26 (2.9%) stddev-sans-first:3.39 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 109.0 112.0 112.0 115.0 103.0 112.0 112.0 111.0 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,046 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.00 stddev:15.02 (9.7%) stddev-sans-first:15.93 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: Values: 150.0 130.0 155.0 170.0 143.0 156.0 155.0 136.0 174.0 132.0 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 163.0 161.0 161.0 162.0 164.0 162.0 162.0 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.60 Median:73.50 stddev:16.50 (22.4%) stddev-sans-first:16.86 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 90.0 103.0 75.0 74.0 73.0 119.0 95.0 73.0 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:95.00 stddev:18.83 (19.8%) stddev-sans-first:19.50 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 133.0 95.0 95.0 96.0 129.0 94.0 95.0 139.0 04:51:18 INFO - 2015-12-15 04:51:18,048 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: Values: 149.0 148.0 149.0 149.0 149.0 149.0 149.0 149.0 149.0 147.0 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.90 Median:76.00 stddev:3.48 (4.6%) stddev-sans-first:3.67 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: Values: 77.0 76.0 74.0 76.0 74.0 76.0 78.0 84.0 72.0 72.0 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 04:51:18 INFO - 2015-12-15 04:51:18,049 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 69.0 69.0 69.0 68.0 69.0 68.0 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.67 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 85.0 84.0 85.0 85.0 85.0 84.0 86.0 84.0 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:128.50 stddev:6.61 (5.1%) stddev-sans-first:6.96 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: Values: 129.0 120.0 121.0 121.0 135.0 128.0 124.0 120.0 135.0 136.0 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:150.50 stddev:6.48 (4.3%) stddev-sans-first:6.06 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: Values: 138.0 138.0 150.0 152.0 155.0 140.0 151.0 152.0 149.0 142.0 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 70.0 72.0 70.0 70.0 69.0 72.0 70.0 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:51:18 INFO - 2015-12-15 04:51:18,050 DEBUG : BROWSER_OUTPUT: 04:51:18 INFO - 2015-12-15 04:51:18,923 INFO : Browser exited with error code: 0 04:51:18 INFO - 2015-12-15 04:51:18,975 INFO : Completed test kraken (00:01:01) 04:51:18 INFO - 2015-12-15 04:51:18,975 INFO : Starting test v8_7 04:51:18 INFO - 2015-12-15 04:51:18,975 DEBUG : operating with platform_type : linux_ 04:51:18 INFO - 2015-12-15 04:51:18,975 INFO : Initialising browser for v8_7 test... 04:51:18 INFO - 2015-12-15 04:51:18,982 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9hcif/profile http://localhost:33714/getInfo.html 04:51:22 INFO - 2015-12-15 04:51:22,957 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:51:22 INFO - 2015-12-15 04:51:22,957 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:51:22 INFO - 2015-12-15 04:51:22,957 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:51:22 INFO - 2015-12-15 04:51:22,957 DEBUG : BROWSER_OUTPUT: __metrics 04:51:23 INFO - 2015-12-15 04:51:23,099 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:51:23 INFO - 2015-12-15 04:51:23,167 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] 04:51:24 INFO - 2015-12-15 04:51:24,301 INFO : Browser initialized. 04:51:24 INFO - 2015-12-15 04:51:24,301 INFO : Running cycle 1/1 for v8_7 test... 04:51:24 INFO - 2015-12-15 04:51:24,302 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9hcif/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:51:36 INFO - 2015-12-15 04:51:36,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 04:51:36 INFO - 2015-12-15 04:51:36,315 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,741 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33714/tests/v8_7/run.html (next: http://localhost:33714/tests/v8_7/run.html) 04:51:57 INFO - 2015-12-15 04:51:57,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 444534784 04:51:57 INFO - 2015-12-15 04:51:57,991 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,991 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:51:57 INFO - 2015-12-15 04:51:57,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:51:57 INFO - 2015-12-15 04:51:57,991 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |0;Richards;166.30633627141194 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.5487804878049 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2014.0845070422536 04:51:57 INFO - 2015-12-15 04:51:57,992 DEBUG : BROWSER_OUTPUT: |5;Earley;791.1392405063291 04:51:57 INFO - 2015-12-15 04:51:57,993 DEBUG : BROWSER_OUTPUT: |6;Boyer;12700 04:51:57 INFO - 2015-12-15 04:51:57,993 DEBUG : BROWSER_OUTPUT: |7;RegExp;27027.027027027027 04:51:57 INFO - 2015-12-15 04:51:57,993 DEBUG : BROWSER_OUTPUT: |8;Splay;594.5786682380672 04:51:57 INFO - 2015-12-15 04:51:57,993 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 04:51:57 INFO - 2015-12-15 04:51:57,993 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: __startTimestamp1450183917988__endTimestamp 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.31 Median:166.31 stddev:0.00 (0.0%) 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: Values: 166.3 04:51:57 INFO - 2015-12-15 04:51:57,994 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.55 Median:190.55 stddev:0.00 (0.0%) 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: Values: 190.5 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: Values: 280.7 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: Values: 5143.6 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 04:51:57 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: Values: 2014.1 04:51:58 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 04:51:58 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: Values: 791.1 04:51:58 INFO - 2015-12-15 04:51:57,995 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12700.00 Median:12700.00 stddev:0.00 (0.0%) 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: Values: 12700.0 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27027.03 Median:27027.03 stddev:0.00 (0.0%) 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: Values: 27027.0 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.58 Median:594.58 stddev:0.00 (0.0%) 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: Values: 594.6 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:51:58 INFO - 2015-12-15 04:51:57,996 DEBUG : BROWSER_OUTPUT: Values: 4822.1 04:51:58 INFO - 2015-12-15 04:51:57,997 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:51:58 INFO - 2015-12-15 04:51:57,997 DEBUG : BROWSER_OUTPUT: 04:51:58 INFO - 2015-12-15 04:51:58,911 INFO : Browser exited with error code: 0 04:51:58 INFO - 2015-12-15 04:51:58,925 INFO : Completed test v8_7 (00:00:39) 04:51:59 INFO - 2015-12-15 04:51:59,014 INFO : Completed test suite (00:20:17) 04:51:59 INFO - 2015-12-15 04:51:59,014 DEBUG : Working with test: dromaeo_css 04:51:59 INFO - 2015-12-15 04:51:59,015 DEBUG : Generating results file: dromaeo_css 04:51:59 INFO - 2015-12-15 04:51:59,016 DEBUG : Working with test: kraken 04:51:59 INFO - 2015-12-15 04:51:59,016 DEBUG : Generating results file: kraken 04:51:59 INFO - 2015-12-15 04:51:59,016 INFO : javascript benchmark 04:51:59 INFO - 2015-12-15 04:51:59,016 DEBUG : Working with test: v8_7 04:51:59 INFO - 2015-12-15 04:51:59,016 DEBUG : Generating results file: v8_7 04:51:59 INFO - 2015-12-15 04:51:59,017 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:59 INFO - 2015-12-15 04:51:59,161 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:51:59 INFO - 2015-12-15 04:51:59,162 DEBUG : process_Request line: dromaeo_css 6222.90 graph.html#tests=[[72,94,35]] 04:51:59 INFO - 2015-12-15 04:51:59,162 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:59 INFO - 2015-12-15 04:51:59,293 DEBUG : process_Request line: kraken 1541.50 graph.html#tests=[[232,94,35]] 04:51:59 INFO - 2015-12-15 04:51:59,293 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:51:59 INFO - 2015-12-15 04:51:59,321 DEBUG : process_Request line: v8_7 19673.24 graph.html#tests=[[230,94,35]] 04:51:59 INFO - 2015-12-15 04:51:59,322 INFO : javascript benchmark 04:51:59 INFO - 2015-12-15 04:51:59,326 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2543.9364015899605, 2634.222904243248, 2647.033832651083, 2653.3234025323563, 2657.534931387007, 4439.8446054388105, 4567.383403240561, 4577.793999270032, 4645.047765208133, 4649.9070018599605, 4543.2276512992785, 4593.356930029799, 4631.444226692802, 4651.906961860761, 4677.812887484505, 4210.410542524049, 4225.0, 4244.193603215394, 4294.549072347405, 4301.505326887401, 4306.332518459643, 4362.0, 4383.0, 4389.517153113155, 4424.115176964604, 4145.54399016108, 4168.749875007509, 4239.7668128252935, 4326.459192600941, 4383.583559561836, 4313.309870420749, 4316.287812510932, 4318.676099292566, 4342.392065110887, 4348.239058164841, 4264.914701705949, 4280.507741609724, 4281.422008028907, 4295.226859165349, 4332.393464914914, 4480.484744254387, 4612.769361531943, 4621.306803979396, 4622.722636641813, 4679.227927391977, 4848.806047758086, 4919.631027672903, 4934.235193545006, 4943.752812359404, 4968.031233909389, 4959.0, 4966.304717339575, 4981.651284410093, 5001.124803159469, 5036.6726162799305, 4446.6220371268155, 4536.591706746342, 4541.613962813198, 4608.654350923694, 4617.353570500132, 5067.0, 5143.254228136899, 5163.741812909339, 5166.380034395821, 5210.21846722987, 4868.0, 4870.6103511718975, 4872.049950259736, 4873.122837889143, 4917.041176970456, 4752.049590081998, 4881.975590122027, 4882.902341953212, 4968.950310496921, 4977.65156439053, 4767.332573439721, 4981.227909674007, 4997.325361076281, 4998.075356059141, 5041.621878359065, 4894.706317620883, 4898.461169271377, 4899.0, 4899.730514821719, 4942.827001054946, 4029.174019326031, 4127.814248358831, 4132.2561938851295, 4132.359484279941, 4177.874663760092, 3574.5531808523933, 3613.2954073955325, 3665.7983810890655, 3667.156553992597, 3678.08047988003, 4286.5284818669925, 4290.678199135077, 4292.205941900758, 4310.31035034393, 4329.631981281626, 4791.089692958397, 4942.481039490802, 4947.455779864212, 4948.8762780930765, 4954.777035033432, 4212.031232816408, 4287.828486860491, 4300.849470268526, 4306.117245964632, 4312.331588603772, 4354.346847972766, 4355.0, 4358.150160718629, 4377.387165796791, 4396.824127034883, 4662.906741865211, 4667.043256132552, 4667.6732628716345, 4697.365855609449, 4702.6708130431225, 4803.711777293373, 4899.314096026488, 4914.066327397783, 4916.70499770015, 4919.237518184687, 4736.550027747358, 4737.952620473751, 4738.455077665974, 4741.786619602057, 4783.449903261169, 4915.852524424273, 4916.778744956414, 4918.631102667386, 4934.037862616755, 4964.67729597575, 4781.258904869751, 4899.975500122477, 4903.53416425439, 4967.155583550732, 4977.776000079933, 4760.262159365304, 4836.443808962014, 4838.2016967201425, 4851.490593487633, 4877.878053048702, 4811.109944660249, 4811.927821082617, 4815.662903596854, 4823.807047718052, 4853.611711063177, 4560.6123479503285, 4608.28571571407, 4617.676762626584, 4727.976360118315, 4776.283557466408, 4772.952270477251, 4835.637327200404, 4859.0, 4863.294822250825, 4902.63230257725, 4775.331453596569, 4782.115308667908, 4785.904281914272, 4787.16224660676, 4840.636952228527], "unit": "ms", "name": "dojo.html", "value": 4543.519948348284}, {"lowerIsBetter": false, "replicates": [556.1213283012839, 558.4304009909889, 565.3611419096418, 565.6323389796631, 579.5971799599278, 26526.336841578945, 27021.91912323507, 27058.864705676468, 35624.10939726508, 36113.81943090281, 39202.41196382057, 39502.20995580087, 39726.0, 39769.80115099427, 39839.0, 7893.4869233499785, 8063.798405039892, 8068.677252909876, 8073.313768329699, 8084.595770211496, 7181.605011724379, 7411.147718012417, 7427.294407031323, 7857.332126769232, 10099.646512372068, 10122.595096196143, 10207.0, 10215.182785377188, 10225.386476811378, 10230.283880128394, 10081.294309398309, 10131.949340253252, 10160.187185025181, 10181.898181018243, 10190.89809101907, 7032.4374050076385, 7211.675474603656, 7215.098112735908, 10076.445795481246, 10395.84406233907, 36918.07704807374, 37351.62648373509, 37499.4375084374, 37505.43741843875, 37519.437208441894, 2986.9850650746826, 3013.3370658455106, 3022.8186308821323, 3025.4350736278316, 3639.926221764559, 28202.576961345596, 28291.434171316458, 28457.288567785763, 28589.0, 29065.709342906513, 3166.841657917095, 3173.730232930204, 3246.6915643014113, 3289.4572395554706, 3299.96700032999, 219983.0, 221622.0, 222276.0, 222522.88738556366, 222689.0, 52605.0, 53659.0, 55184.72407637936, 55452.72273638606, 62850.0, 56411.717941410854, 56785.71607141938, 56850.0, 57237.71381143151, 57255.42744572501, 13902.304884755722, 14037.438502459787, 14074.2962851857, 14081.0, 14092.718145637235, 10705.090067344207, 10756.838647420294, 10762.246642734934, 10768.676939691823, 10777.299475534222, 19313.227470901005, 19459.156956408984, 19498.757373416705, 19547.60904781925, 19724.112414941363, 7634.847303053908, 7750.612469376509, 7800.9219907801335, 7843.411744119214, 7863.685452581947, 779.906411230656, 822.786075620343, 841.2765022081005, 905.9547022648841, 998.4857798233916, 30233.69766302309, 31587.0, 31595.84202079021, 31856.522152167738, 32245.0, 901.2879824938357, 908.1644886704248, 922.262190247799, 959.6449313753816, 985.8422652375585, 13849.653758656113, 13965.930170349084, 13971.441142354191, 14098.71802563943, 14166.079204851652, 318319.0, 325222.0, 325253.0, 325457.0, 327483.0, 47745.76127119412, 48285.0, 48336.0, 48336.7583162089, 48440.0, 1225.6261840138843, 1233.3524899427873, 1241.3420886929941, 1243.8072098824696, 1245.470674963137, 23574.646380303966, 29617.407651847272, 30779.0, 30982.69017309798, 31118.08129139249, 44191.779041105874, 44847.55152448564, 44874.326885096096, 44877.0, 44901.0, 247195.0, 247845.0, 248048.0, 248620.0, 253253.0, 33504.329913402085, 34766.82616587002, 37405.0, 38969.2206155881, 39867.80066099767, 38273.61726382701, 38370.80814595909, 38577.80711096426, 38717.41923871088, 38885.80557097196, 31390.529142063344, 31974.291429816432, 32945.0, 38463.423048654855, 39913.60086399215, 33167.33665326632, 35436.822815886786, 39333.80333098316, 39530.60469395269, 39627.0, 31761.364772703953, 32446.188845279055, 39017.609823901395, 39177.216455671296, 39432.0, 30894.22764430907, 35170.88485173084, 35198.472022919166, 35640.108997275274, 35687.64312356947, 23615.763842361357, 23650.526989460457, 23742.539215980076, 23953.52092958166, 24037.158699445434], "unit": "ms", "name": "ext.html", "value": 17697.727419595903}, {"lowerIsBetter": false, "replicates": [329.11796385686364, 334.2162628635851, 334.4147741452458, 336.22835592315636, 338.6545723362171, 12590.622281331553, 13053.282069486175, 14770.704585908275, 15150.16674082925, 15915.283812228463, 8409.411341206118, 9963.45201013944, 10263.486825658705, 14748.6312842179, 15246.237688115605, 4476.239039363308, 4603.516630753773, 4610.953890461103, 4612.907741845161, 4618.653600979923, 3453.775504592206, 3540.7698499597445, 3541.1324225564645, 3542.0967653248385, 4807.591354734835, 4935.703857768527, 5113.386393632769, 5113.437521872591, 5142.640015198937, 5144.511271429227, 5054.9494505054845, 5085.415177254626, 5089.923651145235, 5198.818041368571, 5213.817516386908, 5019.397672279313, 5027.145385284511, 5033.144365457881, 5037.924431133536, 5040.697558146487, 10881.782364352668, 14761.630959226106, 14964.326605302787, 19418.0, 19426.611467770566, 1642.2960485961355, 1645.679092576948, 1714.8971061736336, 1721.311475409846, 1833.3858157517247, 8734.956325218396, 8779.072071001248, 9079.546022698905, 9271.675491357837, 11126.888731112665, 1652.4419861024414, 1690.0, 1837.4579499047813, 1858.9721154182698, 1870.2238570993022, 53704.0, 53963.0, 55311.0, 55770.72114639441, 55990.72004639992, 9830.655927042519, 9848.655297064712, 9900.603975840886, 9908.851367229498, 9916.553755081039, 12380.752384952251, 12381.938090309492, 12389.132760706663, 12410.131290809737, 12415.75168496625, 6853.0, 6890.31096890307, 6903.585784852925, 6916.723331066802, 7016.7193312267955, 6568.408843204039, 6699.464042876656, 6700.296468870698, 6741.359570840762, 6748.19021717397, 4171.249175148502, 4217.156568686275, 4251.9787401062795, 4254.404383386328, 4264.808083636244, 1617.5470868156935, 1654.8427899349542, 1689.3833750680913, 1727.9913600431917, 1771.3623095685543, 769.3921801776534, 799.2886331165267, 811.0591713612182, 829.5105887526388, 829.7386323308139, 14600.488982885761, 15662.608434789221, 15778.68442631164, 15995.840041599668, 16074.67850643004, 796.5101462600459, 832.7002279179491, 836.9916300837035, 870.4994628088874, 915.6330884663088, 8707.08575599553, 8920.24177944882, 8967.148120928501, 9055.094490551024, 9190.72427827153, 478444.0, 490455.0, 493992.0, 496735.0, 522673.0, 69714.65142674356, 73093.634531827, 74034.6298268516, 75706.24293757102, 76159.61920190364, 1051.9789604207872, 1053.0364716284514, 1065.808154532176, 1080.6974047266779, 1095.5508241620896, 13618.250996194907, 14257.786133207803, 14376.496822611158, 14519.491817786327, 14786.334614942569, 30169.396612068074, 30196.698033019387, 30526.694733053275, 30937.535936960514, 34651.13372165716, 38106.428403573416, 38696.613033870424, 39329.60670393259, 39873.2025359497, 40523.0, 8064.274215320649, 8505.574721264036, 8679.435836670596, 8886.688965886164, 8900.287976961697, 10285.0, 12091.75816483683, 15317.080975141527, 15341.156236407105, 15810.841891580936, 9803.950980245338, 10384.221183411426, 13387.665308366979, 13873.930630346784, 13925.72148557003, 10244.743881403025, 13248.138870973356, 13365.86634133685, 13442.193468391928, 13563.457461701422, 14263.857361426253, 14300.141991480545, 14623.04950178235, 14834.777478337617, 14854.405823766929, 8833.602487888189, 8898.332625053277, 9024.458532488072, 9195.126462986273, 9213.0, 13929.860701393261, 13939.0, 14135.293235337986, 14427.35076921562, 14604.92697536548], "unit": "ms", "name": "jquery.html", "value": 7983.114617780667}, {"lowerIsBetter": false, "replicates": [1439.0574173916089, 1635.1660653066933, 1681.5039563328824, 1700.4133573916995, 1709.581152617609, 5819.854503637411, 6702.396784289413, 6936.6531673416375, 6938.444924406048, 6951.4438844892475, 6747.257801641827, 6889.6555172241315, 6903.654817259142, 6914.204866440361, 6923.273056329089, 1715.6568686262797, 1749.6763098826693, 1914.6457905287532, 1948.4544327588228, 1952.6094781043778, 2005.4084045206625, 2010.909509072088, 2012.8087831655969, 2013.9798602013939, 2015.7379540659767, 1974.9605007899904, 1979.613975274822, 2045.1308194017558, 2045.8158765711082, 2049.549099198174, 1973.7927517610588, 1977.1399441243034, 2001.5996800639857, 2001.609686111209, 2041.1121162294448, 2019.939401817933, 2046.5395286060666, 2051.8768873867616, 2053.5482193917314, 2056.259746491262, 6730.7307707692125, 6809.693563789592, 6859.416949559293, 6886.173659160882, 6890.793276201722, 3840.9039774005873, 3886.0867696091395, 3888.863889763845, 3898.8498392973856, 3902.356111241642, 2448.179859746969, 2577.1624222127884, 2598.8050896182863, 2608.2175347395896, 2616.9345766355805, 809.8299357135008, 827.0984626756864, 852.2840813716446, 855.7047818502607, 859.1236938322938, 8744.956275218647, 8838.072002439716, 8895.377323587352, 8900.198982091579, 8904.51025193614, 3603.5135256740527, 3653.598104208535, 3667.1382225177063, 3676.9080772980888, 3730.6828919542145, 7760.650770715219, 7761.805954851174, 7765.650545725343, 7778.572178530122, 7785.688572457151, 4015.578364271768, 4024.6176613221696, 4025.376066709665, 4027.5368332641533, 4032.3951407288555, 3661.9633803662155, 3664.0656632558525, 3667.4132138857653, 3667.7615954962844, 3668.816559172031, 2793.6507936507937, 2813.620161278201, 3170.9048728538182, 3223.8226897520394, 3291.144302481372, 1038.0864838941684, 1072.463768115942, 1077.3105212663745, 1084.5011294804322, 1085.4898197846999, 904.5296445848122, 906.2025417632441, 909.4952301472614, 951.9956445949451, 1141.57191053355, 6267.435930766253, 6286.371362863677, 6289.182406287154, 6316.936830631635, 6321.810345689637, 1044.5821671331375, 1052.8210204265292, 1055.8152323343384, 1057.545255540125, 1078.9136869050458, 4989.151844186497, 4994.700317980933, 5073.315102461194, 5078.958813443309, 5095.439501654815, 7730.458867879307, 8020.238077382639, 8062.750273707585, 8107.756767296873, 8137.715179968673, 7981.321587665114, 7981.483518131537, 8016.398770092266, 8041.276285134366, 8050.23522765348, 6339.334369891095, 6401.3278605746655, 6461.709223084972, 6487.805365839033, 6505.316941721051, 6002.549808764447, 6018.638881667114, 6043.969780151071, 6069.4840938518955, 6075.0279955208725, 7212.855742885218, 7242.348188663045, 7271.563706177435, 7315.926840731738, 7405.518641288299, 6975.511714179958, 7154.713811447484, 7262.782116536512, 7524.247575242432, 7528.548287102792, 6147.969260153671, 6216.844578885383, 6225.564210505221, 6231.0, 6234.625922444668, 5506.146547285177, 5570.24801651788, 6187.597806142587, 6218.626882387071, 6576.868462630816, 6119.84700382494, 6191.9690401547705, 6256.530760192913, 6268.247810262797, 6371.776987805404, 6029.638221706711, 6048.939510604838, 6189.412005859436, 6195.690215489118, 6207.0, 6191.318954914866, 6211.068339749074, 6211.192544969125, 6260.780872669435, 6306.495480361652, 5675.460831221028, 5721.485066344049, 5729.197912292199, 5744.798932037359, 5747.281589801275, 5813.331466881194, 5828.417158284137, 5843.211166492469, 5843.883122337445, 5849.707514624337], "unit": "ms", "name": "mootools.html", "value": 3909.57436826297}, {"lowerIsBetter": false, "replicates": [291.3241280229867, 300.37821709062234, 301.67871217153737, 304.55991092870784, 305.30695321619936, 5195.740212989354, 5200.557952574031, 5301.734913254336, 5347.973260133704, 5351.598630102739, 5177.534021938025, 5255.710935898524, 5264.684118952866, 5266.5786737061035, 5281.128613778731, 3815.2068527791894, 4042.6361627453525, 4044.939325910114, 4046.9797651011704, 4053.8378464861444, 3875.8255878485393, 3916.4321173429835, 3916.471276377681, 3916.5495967963766, 3917.6669983051474, 3916.784576848272, 3946.427767973642, 3975.0658595230097, 3996.2806694794926, 3999.320115580358, 3982.3030969580495, 3984.322665146932, 3989.0, 3994.1612261425134, 4002.699797515169, 3304.520844477537, 3381.780184288038, 3410.931781364384, 3496.1958749487508, 3508.491268766015, 4980.800767969277, 4998.925016124761, 5001.89996200074, 5026.371703537058, 5029.346184995964, 4570.680052396334, 4573.611243044312, 4578.5650363215445, 4579.267317229261, 4583.8166473341025, 5384.730763461811, 5399.757010934517, 5417.620766546304, 5424.647397919122, 5460.808871689512, 3730.962690373116, 3794.5636251831115, 3797.145642230476, 3811.7712937223855, 3813.180166264239, 5692.288463942007, 5774.942250577483, 5776.855578610526, 5776.971115144397, 5784.479396854304, 3892.824822882977, 3893.1629699614155, 3893.6301051400073, 3894.4742459768136, 3897.5322961244265, 3951.249262640089, 3955.64399204073, 3956.347202711578, 3957.2085582883537, 3957.762534247954, 4459.152760975404, 4536.432945881765, 4545.818167273338, 4560.726356418625, 4563.703359281636, 5481.451854814487, 5486.561075113981, 5488.588355873326, 5491.560675145979, 5495.670259784426, 1381.5233744358181, 1401.1593044173414, 1401.6495876030992, 1401.9088759230822, 1409.7391982483273, 912.6760000199966, 936.765808547863, 942.8491441369348, 943.8678584998106, 955.9091886270793, 4837.105135549935, 4840.83057093, 4848.224284114524, 4856.053069651454, 4856.344393506902, 5645.379008309083, 5672.319321681424, 5677.886442271131, 5681.488666019995, 5701.486866182064, 4863.781129849165, 4868.732219727949, 4870.0, 4870.512948705172, 4877.219644856806, 2993.580898674187, 3049.8932537361084, 3069.938601227963, 3075.4617941860083, 3076.630804303498, 5231.921521177185, 5322.946770532322, 5383.542398896059, 5389.380221274525, 5395.919061214085, 5907.49786268172, 5912.201852749824, 5917.053271476543, 5923.555733320019, 5934.109883517421, 5437.34751829783, 5445.564354851682, 5448.155535891943, 5449.482299181572, 5450.509454149145, 5641.210230567806, 5647.435256474319, 5750.942490575041, 5751.0, 5762.654240745569, 5596.496315331639, 5598.440155984532, 5602.047651899268, 5613.186088017296, 5620.353659329229, 5431.34823821144, 5437.673739575638, 5438.211459338295, 5445.40100588927, 5448.673079615236, 3926.234384295035, 3930.0764320384114, 3930.0960779020415, 3931.488906442144, 3934.9213015740097, 5608.186812912023, 5744.396838331915, 5750.396208398058, 5750.942490575041, 5752.108423194411, 5521.668699878021, 5538.47384498472, 5540.612157148961, 5540.667559946416, 5551.2228288040515, 5530.336359636869, 5530.585206109477, 5536.7785288588, 5537.501624853782, 5539.0, 5271.182966640177, 5407.486288802557, 5413.404525502113, 5418.83743487696, 5421.945780542144, 5561.0, 5564.0, 5564.666120032811, 5566.22072909801, 5576.191452239484, 5432.429594892479, 5435.918461223006, 5439.48324909133, 5439.755211015435, 5442.455754424526], "unit": "ms", "name": "prototype.html", "value": 4116.922678907511}, {"lowerIsBetter": false, "replicates": [655.2988302516308, 699.3425581372148, 726.2519604807048, 789.727543997321, 794.749653859034, 11707.473163707633, 11774.470148843302, 11820.40897955101, 11859.05127589793, 11864.881351186486, 11640.0, 11800.173987820855, 11815.054795616352, 11822.704432389195, 11823.881761182385, 632.3549979021418, 640.3020707428901, 789.9526028438298, 799.6481548118838, 815.8123631564744, 792.809725665839, 794.6781553470854, 795.7334293011819, 795.7453614843253, 798.2097723253966, 652.533438591407, 835.4235577451539, 840.4327079221532, 841.1168273313027, 841.474078700812, 653.5980372071166, 820.6225136437216, 838.5471845203583, 838.6184286149787, 839.4837175137246, 618.6319140111672, 621.1862460177138, 622.2129006806393, 622.240866143309, 625.0592857749059, 11686.415679216005, 11813.822792658117, 11820.23168494045, 11827.112966527546, 11839.526418943233, 10774.622888198875, 11436.71408214793, 11476.368799716012, 11476.885231147666, 11666.300021998708, 9157.313201509913, 9272.119148680864, 9276.489793061379, 9415.670451534232, 9416.246700264031, 3169.6354919184128, 3211.8715251389917, 3238.17426556229, 3238.5627940228005, 3246.594175728034, 38997.610023899964, 39100.41349379761, 39112.21775564501, 39211.8039409804, 39217.411738823655, 9272.629094836131, 9313.53432328381, 9328.0, 9514.238860891111, 9545.0, 16907.309269072994, 16933.915330423515, 16944.40694575684, 16951.321947122222, 16952.067636280124, 6347.1114044033875, 6588.275289718127, 6590.406863382319, 6688.163979502562, 6769.356911093439, 3457.6888080072913, 3480.9547139371944, 3525.524054252643, 3537.398642230827, 3605.2789442111157, 2419.4556224849266, 2450.130203777669, 2453.092355828355, 2454.0551887523075, 2456.7788898999174, 428.4601402233146, 438.0516182464991, 442.4911351945224, 445.11866504321625, 445.59228306100204, 432.75765571280186, 515.0265997265097, 523.4712939930621, 564.4355644355644, 590.3653572409677, 7301.59841208728, 7459.738909138154, 7590.924090759132, 7716.382689384835, 7742.380609551223, 400.991980160401, 483.8209862350953, 498.82042464712674, 560.1569637695243, 568.4656422962402, 3501.2647344057523, 3813.8665146720286, 3831.1954489557506, 3860.8069596520063, 3875.3605655067163, 43037.13925721468, 43043.56956430396, 43180.3522947156, 43785.343219851726, 44037.0, 45272.54727452749, 45524.54475455203, 45730.31404528935, 45792.313115303295, 46561.30158047632, 40503.0, 41363.7931810345, 41538.792306038275, 41645.0, 41984.79007604942, 7602.657880395285, 7764.534127952341, 7858.842823143391, 8060.637271322687, 8161.755147345589, 30442.938099822455, 31175.53236701406, 31177.84411078021, 31387.686123138476, 31721.5241771369, 40160.799196003834, 40223.396649050876, 40224.597754023256, 41022.79488602538, 41161.0, 9634.518274086407, 9651.517424128906, 10015.39907605546, 10229.546616881227, 10311.639092632022, 11276.210665253353, 11373.488193031168, 11558.826617600575, 11667.183297169457, 11831.822522661994, 10411.891950757095, 10741.355518668905, 11001.339919604849, 11086.556537738723, 11489.195756297313, 9583.472908990072, 9718.514074296116, 9738.707838764849, 10485.21360897951, 10597.947010265209, 8785.341099417697, 9251.722448326562, 9808.901910981085, 9868.753281167741, 10276.383416995004, 9267.490288034223, 9324.160825525736, 9408.717738467856, 9422.95288523553, 9602.183814375856, 8695.434796738191, 9186.356955013352, 9297.907020929975, 9312.521221563138, 9612.711618651452], "unit": "ms", "name": "yui.html", "value": 5619.843128508219}], "name": "dromaeo_css", "value": 6222.903302143759}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 109.0, 112.0, 112.0, 115.0, 103.0, 112.0, 112.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [150.0, 130.0, 155.0, 170.0, 143.0, 156.0, 155.0, 136.0, 174.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 161.0, 162.0, 164.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 90.0, 103.0, 75.0, 74.0, 73.0, 119.0, 95.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 84.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 95.0, 95.0, 96.0, 129.0, 94.0, 95.0, 139.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [149.0, 148.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 149.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 74.0, 76.0, 74.0, 76.0, 78.0, 84.0, 72.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 75.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 86.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.7}, {"lowerIsBetter": true, "replicates": [129.0, 120.0, 121.0, 121.0, 135.0, 128.0, 124.0, 120.0, 135.0, 136.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [138.0, 138.0, 150.0, 152.0, 155.0, 140.0, 151.0, 152.0, 149.0, 142.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 72.0, 70.0, 70.0, 69.0, 72.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1541.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.30633627141194], "unit": "score", "name": "Richards", "value": 212.27092600000003}, {"lowerIsBetter": false, "replicates": [190.5487804878049], "unit": "score", "name": "DeltaBlue", "value": 346.9872640000001}, {"lowerIsBetter": false, "replicates": [280.662363177098], "unit": "score", "name": "Encrypt", "value": 948.4029029999999}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12700.0], "unit": "score", "name": "Boyer", "value": 52.47740157480315}, {"lowerIsBetter": false, "replicates": [27027.027027027027], "unit": "score", "name": "RegExp", "value": 33.70644499999999}, {"lowerIsBetter": false, "replicates": [594.5786682380672], "unit": "score", "name": "Splay", "value": 137.05671655104067}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19673.238040957516}]} 04:51:59 INFO - RETURN: dromaeo_css: 6222.90 04:51:59 INFO - RETURN: kraken: 1541.50 04:51:59 INFO - RETURN: v8_7: 19673.24 04:51:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19673.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1541.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6222.90"}}} 04:51:59 INFO - Return code: 0 04:51:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:51:59 INFO - # TBPL SUCCESS # 04:51:59 INFO - Running post-action listener: _resource_record_post_action 04:51:59 INFO - Running post-run listener: _resource_record_post_run 04:52:00 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 12288; Write bytes: 508444672; Read time: 308; Write time: 457484 04:52:00 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 231133184; Read time: 92; Write time: 267588 04:52:00 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276918272; Read time: 216; Write time: 189872 04:52:00 INFO - Running post-run listener: _upload_blobber_files 04:52:00 INFO - Blob upload gear active. 04:52:00 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:52:00 INFO - Copying logs to upload dir... 04:52:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.623822 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-12-15 04:51:58.347002) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 04:51:58.350382) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010006 build_url: 'https://queue.taskcluster.net/v1/task/A2hU46GWRaWV1eprmCXE8Q/artifacts/public/build/firefox-46.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-15 04:51:58.400920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:51:58.401274) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450177967.446387-1981162762 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 04:51:58.450575) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 04:51:58.450879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 04:51:58.451159) ========= ========= Total master_lag: 0.27 =========