builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1449659064.07 results: success (0) buildid: 20151209020345 builduid: 1745898ae9794011b7e2eebdacb155a5 revision: 5211eaa88dca7f1105865edcc16aa29ef6a6f4b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.071228) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.071688) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.072042) ========= 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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006280 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.095577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.095889) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.121775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.122086) ========= 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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.044710 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.177966) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.178277) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.178691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.179013) ========= 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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 03:04:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 217M=0s 2015-12-09 03:04:24 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111984 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.303547) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.303866) ========= 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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.128007 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.443165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.443528) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5211eaa88dca7f1105865edcc16aa29ef6a6f4b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5211eaa88dca7f1105865edcc16aa29ef6a6f4b6 --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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 03:04:24,768 truncating revision to first 12 chars 2015-12-09 03:04:24,768 Setting DEBUG logging. 2015-12-09 03:04:24,768 attempt 1/10 2015-12-09 03:04:24,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5211eaa88dca?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 03:04:24,994 unpacking tar archive at: fx-team-5211eaa88dca/testing/mozharness/ program finished with exit code 0 elapsedTime=0.495631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.952739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.953052) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.961100) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.961391) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 03:04:24.961832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-09 03:04:24.962178) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:25 INFO - MultiFileLogger online at 20151209 03:04:25 in /builds/slave/test 03:04:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 03:04:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:25 INFO - {'append_to_log': False, 03:04:25 INFO - 'base_work_dir': '/builds/slave/test', 03:04:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:04:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:25 INFO - 'branch': 'Fx-Team-Non-PGO', 03:04:25 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:25 INFO - 'config_files': ('talos/linux_config.py',), 03:04:25 INFO - 'default_actions': ('clobber', 03:04:25 INFO - 'read-buildbot-config', 03:04:25 INFO - 'download-and-extract', 03:04:25 INFO - 'populate-webroot', 03:04:25 INFO - 'create-virtualenv', 03:04:25 INFO - 'install', 03:04:25 INFO - 'run-tests'), 03:04:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:25 INFO - 'download_minidump_stackwalk': True, 03:04:25 INFO - 'download_symbols': 'ondemand', 03:04:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:25 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:25 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:25 INFO - 'installer_path': 'installer.exe', 03:04:25 INFO - 'log_level': 'info', 03:04:25 INFO - 'log_name': 'talos', 03:04:25 INFO - 'log_to_console': True, 03:04:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:25 INFO - 'opt_config_files': (), 03:04:25 INFO - 'pip_index': False, 03:04:25 INFO - 'sps_profile': False, 03:04:25 INFO - 'sps_profile_interval': 0, 03:04:25 INFO - 'suite': 'dromaeojs', 03:04:25 INFO - 'system_bits': '64', 03:04:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:25 INFO - 'title': 'talos-linux64-ix-066', 03:04:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:25 INFO - 'use_talos_json': True, 03:04:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:25 INFO - 'work_dir': 'build'} 03:04:25 INFO - ##### 03:04:25 INFO - ##### Running clobber step. 03:04:25 INFO - ##### 03:04:25 INFO - Running pre-action listener: _resource_record_pre_action 03:04:25 INFO - Running main action method: clobber 03:04:25 INFO - rmtree: /builds/slave/test/build 03:04:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:26 INFO - Running post-action listener: _resource_record_post_action 03:04:26 INFO - ##### 03:04:26 INFO - ##### Running read-buildbot-config step. 03:04:26 INFO - ##### 03:04:26 INFO - Running pre-action listener: _resource_record_pre_action 03:04:26 INFO - Running main action method: read_buildbot_config 03:04:26 INFO - Using buildbot properties: 03:04:26 INFO - { 03:04:26 INFO - "properties": { 03:04:26 INFO - "buildnumber": 1183, 03:04:26 INFO - "product": "firefox", 03:04:26 INFO - "script_repo_revision": "production", 03:04:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:04:26 INFO - "repository": "", 03:04:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:04:26 INFO - "buildid": "20151209020345", 03:04:26 INFO - "slavename": "talos-linux64-ix-066", 03:04:26 INFO - "pgo_build": "False", 03:04:26 INFO - "basedir": "/builds/slave/test", 03:04:26 INFO - "project": "", 03:04:26 INFO - "platform": "ubuntu64_hw", 03:04:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:04:26 INFO - "slavebuilddir": "test", 03:04:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:04:26 INFO - "branch": "fx-team", 03:04:26 INFO - "repo_path": "integration/fx-team", 03:04:26 INFO - "stage_platform": "linux64", 03:04:26 INFO - "builduid": "1745898ae9794011b7e2eebdacb155a5", 03:04:26 INFO - "revision": "5211eaa88dca7f1105865edcc16aa29ef6a6f4b6" 03:04:26 INFO - }, 03:04:26 INFO - "sourcestamp": { 03:04:26 INFO - "repository": "", 03:04:26 INFO - "hasPatch": false, 03:04:26 INFO - "project": "", 03:04:26 INFO - "branch": "fx-team-linux64-talos", 03:04:26 INFO - "changes": [ 03:04:26 INFO - { 03:04:26 INFO - "category": null, 03:04:26 INFO - "files": [ 03:04:26 INFO - { 03:04:26 INFO - "url": null, 03:04:26 INFO - "name": "https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:04:26 INFO - } 03:04:26 INFO - ], 03:04:26 INFO - "repository": "", 03:04:26 INFO - "rev": "5211eaa88dca7f1105865edcc16aa29ef6a6f4b6", 03:04:26 INFO - "who": "cbook@mozilla.com", 03:04:26 INFO - "when": 1449658965, 03:04:26 INFO - "number": 7140899, 03:04:26 INFO - "comments": "Bug 1230839 - Fix mixing reference to AppConstants in globalOverlay.js r=MattN", 03:04:26 INFO - "project": "", 03:04:26 INFO - "at": "Wed 09 Dec 2015 03:02:45", 03:04:26 INFO - "branch": "fx-team-linux64-talos", 03:04:26 INFO - "revlink": "", 03:04:26 INFO - "properties": [ 03:04:26 INFO - [ 03:04:26 INFO - "buildid", 03:04:26 INFO - "20151209020345", 03:04:26 INFO - "Change" 03:04:26 INFO - ], 03:04:26 INFO - [ 03:04:26 INFO - "builduid", 03:04:26 INFO - "1745898ae9794011b7e2eebdacb155a5", 03:04:26 INFO - "Change" 03:04:26 INFO - ], 03:04:26 INFO - [ 03:04:26 INFO - "pgo_build", 03:04:26 INFO - "False", 03:04:26 INFO - "Change" 03:04:26 INFO - ] 03:04:26 INFO - ], 03:04:26 INFO - "revision": "5211eaa88dca7f1105865edcc16aa29ef6a6f4b6" 03:04:26 INFO - } 03:04:26 INFO - ], 03:04:26 INFO - "revision": "5211eaa88dca7f1105865edcc16aa29ef6a6f4b6" 03:04:26 INFO - } 03:04:26 INFO - } 03:04:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:04:26 INFO - Running post-action listener: _resource_record_post_action 03:04:26 INFO - ##### 03:04:26 INFO - ##### Running download-and-extract step. 03:04:26 INFO - ##### 03:04:26 INFO - Running pre-action listener: _resource_record_pre_action 03:04:26 INFO - Running main action method: download_and_extract 03:04:26 INFO - mkdir: /builds/slave/test/build/tests 03:04:26 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')]} 03:04:26 INFO - https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:04:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/test_packages.json 03:04:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/test_packages.json 03:04:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:04:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:04:28 INFO - Downloaded 1302 bytes. 03:04:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:04:28 INFO - Using the following test package requirements: 03:04:28 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:28 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:04:28 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'jsshell-linux-x86_64.zip'], 03:04:28 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:04:28 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:28 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:04:28 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:04:28 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:04:28 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:28 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:28 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:04:28 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:04:28 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')]} 03:04:28 INFO - https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:29 INFO - Downloaded 21859668 bytes. 03:04:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:04:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:04:30 INFO - Return code: 0 03:04:30 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:04:30 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')]} 03:04:30 INFO - https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:31 INFO - Downloaded 21859668 bytes. 03:04:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:04:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:04:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:04:32 INFO - Return code: 0 03:04:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:32 INFO - https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:04:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:04:33 INFO - Downloaded 11132038 bytes. 03:04:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:04:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:04:34 INFO - Return code: 0 03:04:34 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')]} 03:04:34 INFO - https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:04:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:04:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:04:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:04:35 INFO - Downloaded 57731378 bytes. 03:04:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:04:35 INFO - mkdir: /builds/slave/test/properties 03:04:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:04:35 INFO - Writing to file /builds/slave/test/properties/build_url 03:04:35 INFO - Contents: 03:04:35 INFO - build_url:https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:04:35 INFO - Running post-action listener: _resource_record_post_action 03:04:35 INFO - Running post-action listener: set_extra_try_arguments 03:04:35 INFO - ##### 03:04:35 INFO - ##### Running populate-webroot step. 03:04:35 INFO - ##### 03:04:35 INFO - Running pre-action listener: _resource_record_pre_action 03:04:35 INFO - Running main action method: populate_webroot 03:04:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:04:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:04:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:04:35 INFO - '--tppagecycles', 03:04:35 INFO - '7'], 03:04:35 INFO - 'tests': ['tsvgm']}}, 03:04:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:04:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:04:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:04:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:04:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'tests': ['damp', 'tps']}, 03:04:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['damp', 'tps']}, 03:04:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:04:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:35 INFO - 'other': {'tests': ['a11yr', 03:04:35 INFO - 'ts_paint', 03:04:35 INFO - 'tpaint', 03:04:35 INFO - 'sessionrestore', 03:04:35 INFO - 'sessionrestore_no_auto_restore']}, 03:04:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['a11yr', 03:04:35 INFO - 'ts_paint', 03:04:35 INFO - 'tpaint', 03:04:35 INFO - 'sessionrestore', 03:04:35 INFO - 'sessionrestore_no_auto_restore']}, 03:04:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['a11yr', 03:04:35 INFO - 'ts_paint', 03:04:35 INFO - 'tpaint', 03:04:35 INFO - 'sessionrestore', 03:04:35 INFO - 'sessionrestore_no_auto_restore']}, 03:04:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['a11yr', 03:04:35 INFO - 'ts_paint', 03:04:35 INFO - 'tpaint', 03:04:35 INFO - 'sessionrestore', 03:04:35 INFO - 'sessionrestore_no_auto_restore']}, 03:04:35 INFO - 'other_l64': {'tests': ['a11yr', 03:04:35 INFO - 'ts_paint', 03:04:35 INFO - 'tpaint', 03:04:35 INFO - 'sessionrestore', 03:04:35 INFO - 'sessionrestore_no_auto_restore']}, 03:04:35 INFO - 'other_nol64': {'tests': ['a11yr', 03:04:35 INFO - 'ts_paint', 03:04:35 INFO - 'tpaint', 03:04:35 INFO - 'sessionrestore', 03:04:35 INFO - 'sessionrestore_no_auto_restore']}, 03:04:35 INFO - 'svgr': {'tests': ['tsvgx', 03:04:35 INFO - 'tsvgr_opacity', 03:04:35 INFO - 'tart', 03:04:35 INFO - 'tscrollx', 03:04:35 INFO - 'cart']}, 03:04:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['tsvgx', 03:04:35 INFO - 'tsvgr_opacity', 03:04:35 INFO - 'tart', 03:04:35 INFO - 'tscrollx', 03:04:35 INFO - 'cart']}, 03:04:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'tests': ['tp5o']}, 03:04:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'talos_options': ['--e10s'], 03:04:35 INFO - 'tests': ['tp5o']}, 03:04:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'talos_options': ['--xperf_path', 03:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:35 INFO - 'tests': ['tp5n']}, 03:04:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:35 INFO - 'talos_options': ['--e10s', 03:04:35 INFO - '--xperf_path', 03:04:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:35 INFO - 'tests': ['tp5n']}}, 03:04:35 INFO - 'talos.zip': {'path': '', 03:04:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:04:35 INFO - Running post-action listener: _resource_record_post_action 03:04:35 INFO - ##### 03:04:35 INFO - ##### Running create-virtualenv step. 03:04:35 INFO - ##### 03:04:35 INFO - Running pre-action listener: _resource_record_pre_action 03:04:35 INFO - Running main action method: create_virtualenv 03:04:35 INFO - Creating virtualenv /builds/slave/test/build/venv 03:04:35 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 03:04:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:04:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:04:35 INFO - Using real prefix '/usr' 03:04:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:04:36 INFO - Installing distribute.............................................................................................................................................................................................done. 03:04:37 INFO - Installing pip.................done. 03:04:37 INFO - Return code: 0 03:04:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:04:37 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')]} 03:04:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:37 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')]} 03:04:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:37 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:37 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 03:04:37 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 03:04:37 INFO - Using env: {'DISPLAY': ':0', 03:04:37 INFO - 'HOME': '/home/cltbld', 03:04:37 INFO - 'LANG': 'en_US.UTF-8', 03:04:37 INFO - 'LANGUAGE': 'en_US:en', 03:04:37 INFO - 'LOGNAME': 'cltbld', 03:04:37 INFO - 'MAIL': '/var/mail/cltbld', 03:04:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:37 INFO - 'MOZ_NO_REMOTE': '1', 03:04:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:37 INFO - 'NO_EM_RESTART': '1', 03:04:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:37 INFO - 'PWD': '/builds/slave/test', 03:04:37 INFO - 'SHELL': '/bin/bash', 03:04:37 INFO - 'SHLVL': '1', 03:04:37 INFO - 'TERM': 'linux', 03:04:37 INFO - 'TMOUT': '86400', 03:04:37 INFO - 'USER': 'cltbld', 03:04:37 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:37 INFO - '_': '/tools/buildbot/bin/python'} 03:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:38 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 03:04:38 INFO - Cleaning up... 03:04:38 INFO - Return code: 0 03:04:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:04:38 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')]} 03:04:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:38 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')]} 03:04:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:38 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:38 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 03:04:38 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 03:04:38 INFO - Using env: {'DISPLAY': ':0', 03:04:38 INFO - 'HOME': '/home/cltbld', 03:04:38 INFO - 'LANG': 'en_US.UTF-8', 03:04:38 INFO - 'LANGUAGE': 'en_US:en', 03:04:38 INFO - 'LOGNAME': 'cltbld', 03:04:38 INFO - 'MAIL': '/var/mail/cltbld', 03:04:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:38 INFO - 'MOZ_NO_REMOTE': '1', 03:04:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:38 INFO - 'NO_EM_RESTART': '1', 03:04:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:38 INFO - 'PWD': '/builds/slave/test', 03:04:38 INFO - 'SHELL': '/bin/bash', 03:04:38 INFO - 'SHLVL': '1', 03:04:38 INFO - 'TERM': 'linux', 03:04:38 INFO - 'TMOUT': '86400', 03:04:38 INFO - 'USER': 'cltbld', 03:04:38 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:38 INFO - '_': '/tools/buildbot/bin/python'} 03:04:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:38 INFO - Downloading/unpacking psutil>=0.7.1 03:04:38 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 03:04:38 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 03:04:38 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 03:04:38 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 03:04:38 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 03:04:38 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 03:04:40 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:04:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:04:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:04:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:40 INFO - Installing collected packages: psutil 03:04:40 INFO - Running setup.py install for psutil 03:04:40 INFO - building 'psutil._psutil_linux' extension 03:04:40 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 03:04:40 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 03:04:40 INFO - building 'psutil._psutil_posix' extension 03:04:40 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 03:04:40 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 03:04:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:04:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:04:41 INFO - Successfully installed psutil 03:04:41 INFO - Cleaning up... 03:04:41 INFO - Return code: 0 03:04:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:04:41 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')]} 03:04:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:41 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')]} 03:04:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:41 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:41 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 03:04:41 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 03:04:41 INFO - Using env: {'DISPLAY': ':0', 03:04:41 INFO - 'HOME': '/home/cltbld', 03:04:41 INFO - 'LANG': 'en_US.UTF-8', 03:04:41 INFO - 'LANGUAGE': 'en_US:en', 03:04:41 INFO - 'LOGNAME': 'cltbld', 03:04:41 INFO - 'MAIL': '/var/mail/cltbld', 03:04:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:41 INFO - 'MOZ_NO_REMOTE': '1', 03:04:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:41 INFO - 'NO_EM_RESTART': '1', 03:04:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:41 INFO - 'PWD': '/builds/slave/test', 03:04:41 INFO - 'SHELL': '/bin/bash', 03:04:41 INFO - 'SHLVL': '1', 03:04:41 INFO - 'TERM': 'linux', 03:04:41 INFO - 'TMOUT': '86400', 03:04:41 INFO - 'USER': 'cltbld', 03:04:41 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:41 INFO - '_': '/tools/buildbot/bin/python'} 03:04:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:04:42 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 03:04:42 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 03:04:42 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 03:04:42 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 03:04:42 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 03:04:42 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 03:04:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:04:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:04:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:04:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:04:43 INFO - Installing collected packages: mozsystemmonitor 03:04:43 INFO - Running setup.py install for mozsystemmonitor 03:04:43 INFO - Successfully installed mozsystemmonitor 03:04:43 INFO - Cleaning up... 03:04:43 INFO - Return code: 0 03:04:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:04: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')]} 03:04:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04: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')]} 03:04:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:43 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:43 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 03:04:43 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 03:04:43 INFO - Using env: {'DISPLAY': ':0', 03:04:43 INFO - 'HOME': '/home/cltbld', 03:04:43 INFO - 'LANG': 'en_US.UTF-8', 03:04:43 INFO - 'LANGUAGE': 'en_US:en', 03:04:43 INFO - 'LOGNAME': 'cltbld', 03:04:43 INFO - 'MAIL': '/var/mail/cltbld', 03:04:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:43 INFO - 'MOZ_NO_REMOTE': '1', 03:04:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:43 INFO - 'NO_EM_RESTART': '1', 03:04:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:43 INFO - 'PWD': '/builds/slave/test', 03:04:43 INFO - 'SHELL': '/bin/bash', 03:04:43 INFO - 'SHLVL': '1', 03:04:43 INFO - 'TERM': 'linux', 03:04:43 INFO - 'TMOUT': '86400', 03:04:43 INFO - 'USER': 'cltbld', 03:04:43 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:43 INFO - '_': '/tools/buildbot/bin/python'} 03:04:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:44 INFO - Downloading/unpacking blobuploader==1.2.4 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:44 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 03:04:45 INFO - Downloading blobuploader-1.2.4.tar.gz 03:04:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:04:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:04:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:04:45 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 03:04:45 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 03:04:45 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 03:04:45 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 03:04:45 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 03:04:45 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 03:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:04:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:04:46 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 03:04:46 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 03:04:46 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 03:04:46 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 03:04:46 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 03:04:46 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 03:04:46 INFO - Downloading docopt-0.6.1.tar.gz 03:04:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:04:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:04:46 INFO - Installing collected packages: blobuploader, requests, docopt 03:04:46 INFO - Running setup.py install for blobuploader 03:04:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:04:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:04:46 INFO - Running setup.py install for requests 03:04:46 INFO - Running setup.py install for docopt 03:04:47 INFO - Successfully installed blobuploader requests docopt 03:04:47 INFO - Cleaning up... 03:04:47 INFO - Return code: 0 03:04:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:47 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')]} 03:04:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:47 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')]} 03:04:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:47 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:47 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 03:04:47 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 03:04:47 INFO - Using env: {'DISPLAY': ':0', 03:04:47 INFO - 'HOME': '/home/cltbld', 03:04:47 INFO - 'LANG': 'en_US.UTF-8', 03:04:47 INFO - 'LANGUAGE': 'en_US:en', 03:04:47 INFO - 'LOGNAME': 'cltbld', 03:04:47 INFO - 'MAIL': '/var/mail/cltbld', 03:04:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:47 INFO - 'MOZ_NO_REMOTE': '1', 03:04:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:47 INFO - 'NO_EM_RESTART': '1', 03:04:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:47 INFO - 'PWD': '/builds/slave/test', 03:04:47 INFO - 'SHELL': '/bin/bash', 03:04:47 INFO - 'SHLVL': '1', 03:04:47 INFO - 'TERM': 'linux', 03:04:47 INFO - 'TMOUT': '86400', 03:04:47 INFO - 'USER': 'cltbld', 03:04:47 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:47 INFO - '_': '/tools/buildbot/bin/python'} 03:04:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:47 INFO - Running setup.py (path:/tmp/pip-CCU8yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:47 INFO - Running setup.py (path:/tmp/pip-H2QObC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:47 INFO - Running setup.py (path:/tmp/pip-JW4dIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:47 INFO - Running setup.py (path:/tmp/pip-FWtmcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:47 INFO - Running setup.py (path:/tmp/pip-v_ZPz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:47 INFO - Running setup.py (path:/tmp/pip-B730Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:47 INFO - Running setup.py (path:/tmp/pip-_v1Z0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:47 INFO - Running setup.py (path:/tmp/pip-ACgoGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:47 INFO - Running setup.py (path:/tmp/pip-YoEH50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:47 INFO - Running setup.py (path:/tmp/pip-Q_hlqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:48 INFO - Running setup.py (path:/tmp/pip-NijXz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:48 INFO - Running setup.py (path:/tmp/pip-2Wspc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:48 INFO - Running setup.py (path:/tmp/pip-YyytFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:48 INFO - Running setup.py (path:/tmp/pip-GvsqQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:48 INFO - Running setup.py (path:/tmp/pip-62klaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:48 INFO - Running setup.py (path:/tmp/pip-6arwty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:48 INFO - Running setup.py (path:/tmp/pip-78FzV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:04:48 INFO - Running setup.py install for manifestparser 03:04:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Running setup.py install for mozcrash 03:04:48 INFO - Running setup.py install for mozdebug 03:04:48 INFO - Running setup.py install for mozdevice 03:04:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:04:48 INFO - Running setup.py install for mozfile 03:04:49 INFO - Running setup.py install for mozhttpd 03:04:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for mozinfo 03:04:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for mozInstall 03:04:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for mozleak 03:04:49 INFO - Running setup.py install for mozlog 03:04:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for moznetwork 03:04:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for mozprocess 03:04:49 INFO - Running setup.py install for mozprofile 03:04:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for mozrunner 03:04:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:04:49 INFO - Running setup.py install for mozscreenshot 03:04:50 INFO - Running setup.py install for moztest 03:04:50 INFO - Running setup.py install for mozversion 03:04:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:04:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:04:50 INFO - Cleaning up... 03:04:50 INFO - Return code: 0 03:04:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:50 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')]} 03:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:50 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')]} 03:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:50 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:50 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 03:04:50 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 03:04:50 INFO - Using env: {'DISPLAY': ':0', 03:04:50 INFO - 'HOME': '/home/cltbld', 03:04:50 INFO - 'LANG': 'en_US.UTF-8', 03:04:50 INFO - 'LANGUAGE': 'en_US:en', 03:04:50 INFO - 'LOGNAME': 'cltbld', 03:04:50 INFO - 'MAIL': '/var/mail/cltbld', 03:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:50 INFO - 'MOZ_NO_REMOTE': '1', 03:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:50 INFO - 'NO_EM_RESTART': '1', 03:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:50 INFO - 'PWD': '/builds/slave/test', 03:04:50 INFO - 'SHELL': '/bin/bash', 03:04:50 INFO - 'SHLVL': '1', 03:04:50 INFO - 'TERM': 'linux', 03:04:50 INFO - 'TMOUT': '86400', 03:04:50 INFO - 'USER': 'cltbld', 03:04:50 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:50 INFO - '_': '/tools/buildbot/bin/python'} 03:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:04:50 INFO - Running setup.py (path:/tmp/pip-Gm7apk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:04:50 INFO - Running setup.py (path:/tmp/pip-w58SyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:04:50 INFO - Running setup.py (path:/tmp/pip-xs3spV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:04:50 INFO - Running setup.py (path:/tmp/pip-UO1dzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:04:50 INFO - Running setup.py (path:/tmp/pip-UJgDVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:04:50 INFO - Running setup.py (path:/tmp/pip-cJumBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:04:50 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)) 03:04:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:04:51 INFO - Running setup.py (path:/tmp/pip-BhQgjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:04:51 INFO - Running setup.py (path:/tmp/pip-ZTMOND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:04:51 INFO - Running setup.py (path:/tmp/pip-Xl5cn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:04:51 INFO - Running setup.py (path:/tmp/pip-_3KUhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:04:51 INFO - Running setup.py (path:/tmp/pip-CodLK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:04:51 INFO - Running setup.py (path:/tmp/pip-eNZeFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:04:51 INFO - Running setup.py (path:/tmp/pip-9uqqQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:04:51 INFO - Running setup.py (path:/tmp/pip-AG2TzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:51 INFO - Running setup.py (path:/tmp/pip-PpSel_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:04:51 INFO - Running setup.py (path:/tmp/pip-48uEuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:04:51 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)) 03:04:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:04:51 INFO - Running setup.py (path:/tmp/pip-U5yo1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:04:51 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)) 03:04:51 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)) 03:04:51 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)) 03:04:51 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)) 03:04:51 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)) 03:04:51 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)) 03:04:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 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 03:04:51 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 03:04:53 INFO - Downloading blessings-1.5.1.tar.gz 03:04:53 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 03:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:04:53 INFO - Installing collected packages: blessings 03:04:53 INFO - Running setup.py install for blessings 03:04:53 INFO - Successfully installed blessings 03:04:53 INFO - Cleaning up... 03:04:53 INFO - Return code: 0 03:04:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:04:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:53 INFO - Reading from file tmpfile_stdout 03:04:53 INFO - Current package versions: 03:04:53 INFO - argparse == 1.2.1 03:04:53 INFO - blessings == 1.5.1 03:04:53 INFO - blobuploader == 1.2.4 03:04:53 INFO - docopt == 0.6.1 03:04:53 INFO - manifestparser == 1.1 03:04:53 INFO - mozInstall == 1.12 03:04:53 INFO - mozcrash == 0.16 03:04:53 INFO - mozdebug == 0.1 03:04:53 INFO - mozdevice == 0.47 03:04:53 INFO - mozfile == 1.2 03:04:53 INFO - mozhttpd == 0.7 03:04:53 INFO - mozinfo == 0.9 03:04:53 INFO - mozleak == 0.1 03:04:53 INFO - mozlog == 3.1 03:04:53 INFO - moznetwork == 0.27 03:04:53 INFO - mozprocess == 0.22 03:04:53 INFO - mozprofile == 0.27 03:04:53 INFO - mozrunner == 6.11 03:04:53 INFO - mozscreenshot == 0.1 03:04:53 INFO - mozsystemmonitor == 0.0 03:04:53 INFO - moztest == 0.7 03:04:53 INFO - mozversion == 1.4 03:04:53 INFO - psutil == 3.1.1 03:04:53 INFO - requests == 1.2.3 03:04:53 INFO - wsgiref == 0.1.2 03:04:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:53 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:53 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 03:04:53 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 03:04:53 INFO - Using env: {'DISPLAY': ':0', 03:04:53 INFO - 'HOME': '/home/cltbld', 03:04:53 INFO - 'LANG': 'en_US.UTF-8', 03:04:53 INFO - 'LANGUAGE': 'en_US:en', 03:04:53 INFO - 'LOGNAME': 'cltbld', 03:04:53 INFO - 'MAIL': '/var/mail/cltbld', 03:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:53 INFO - 'MOZ_NO_REMOTE': '1', 03:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:53 INFO - 'NO_EM_RESTART': '1', 03:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:53 INFO - 'PWD': '/builds/slave/test', 03:04:53 INFO - 'SHELL': '/bin/bash', 03:04:53 INFO - 'SHLVL': '1', 03:04:53 INFO - 'TERM': 'linux', 03:04:53 INFO - 'TMOUT': '86400', 03:04:53 INFO - 'USER': 'cltbld', 03:04:53 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:53 INFO - '_': '/tools/buildbot/bin/python'} 03:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 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)) 03:04:54 INFO - Cleaning up... 03:04:54 INFO - Return code: 0 03:04:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:04:54 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')]} 03:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:54 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')]} 03:04:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:54 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:54 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 03:04:54 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 03:04:54 INFO - Using env: {'DISPLAY': ':0', 03:04:54 INFO - 'HOME': '/home/cltbld', 03:04:54 INFO - 'LANG': 'en_US.UTF-8', 03:04:54 INFO - 'LANGUAGE': 'en_US:en', 03:04:54 INFO - 'LOGNAME': 'cltbld', 03:04:54 INFO - 'MAIL': '/var/mail/cltbld', 03:04:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:54 INFO - 'MOZ_NO_REMOTE': '1', 03:04:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:54 INFO - 'NO_EM_RESTART': '1', 03:04:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:54 INFO - 'PWD': '/builds/slave/test', 03:04:54 INFO - 'SHELL': '/bin/bash', 03:04:54 INFO - 'SHLVL': '1', 03:04:54 INFO - 'TERM': 'linux', 03:04:54 INFO - 'TMOUT': '86400', 03:04:54 INFO - 'USER': 'cltbld', 03:04:54 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:54 INFO - '_': '/tools/buildbot/bin/python'} 03:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:54 INFO - Downloading/unpacking jsonschema 03:04:54 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 03:04:54 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 03:04:54 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 03:04:54 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 03:04:54 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 03:04:54 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 03:04:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:04:56 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 03:04:56 INFO - Downloading/unpacking functools32 (from jsonschema) 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 INFO - Downloading functools32-3.2.3-2.tar.gz 03:04:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:04:56 INFO - warning: no files found matching '*.txt' 03:04:56 INFO - no previously-included directories found matching 'build' 03:04:56 INFO - no previously-included directories found matching 'dist' 03:04:56 INFO - no previously-included directories found matching '.git*' 03:04:56 INFO - Installing collected packages: jsonschema, functools32 03:04:56 INFO - Running setup.py install for functools32 03:04:56 INFO - warning: no files found matching '*.txt' 03:04:56 INFO - no previously-included directories found matching 'build' 03:04:56 INFO - no previously-included directories found matching 'dist' 03:04:56 INFO - no previously-included directories found matching '.git*' 03:04:56 INFO - Successfully installed jsonschema functools32 03:04:56 INFO - Cleaning up... 03:04:56 INFO - Return code: 0 03:04:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:04:56 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 0x7ff515d83f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x227f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, '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': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', '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 03:04:56 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 03:04:56 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 03:04:56 INFO - Using env: {'DISPLAY': ':0', 03:04:56 INFO - 'HOME': '/home/cltbld', 03:04:56 INFO - 'LANG': 'en_US.UTF-8', 03:04:56 INFO - 'LANGUAGE': 'en_US:en', 03:04:56 INFO - 'LOGNAME': 'cltbld', 03:04:56 INFO - 'MAIL': '/var/mail/cltbld', 03:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:04:56 INFO - 'MOZ_NO_REMOTE': '1', 03:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:04:56 INFO - 'NO_EM_RESTART': '1', 03:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:04:56 INFO - 'PWD': '/builds/slave/test', 03:04:56 INFO - 'SHELL': '/bin/bash', 03:04:56 INFO - 'SHLVL': '1', 03:04:56 INFO - 'TERM': 'linux', 03:04:56 INFO - 'TMOUT': '86400', 03:04:56 INFO - 'USER': 'cltbld', 03:04:56 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:04:56 INFO - '_': '/tools/buildbot/bin/python'} 03:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:04:56 INFO - Downloading/unpacking flake8 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 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 03:04:56 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 03:04:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:04:58 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 03:04:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:04:58 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 03:04:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 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 03:04:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:04:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:04:59 INFO - no previously-included directories found matching 'docs/_build' 03:04:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:04:59 INFO - Running setup.py install for pep8 03:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:04:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:04:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:04:59 INFO - no previously-included directories found matching 'docs/_build' 03:04:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:04:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:04:59 INFO - Cleaning up... 03:04:59 INFO - Return code: 0 03:04:59 INFO - Running post-action listener: _resource_record_post_action 03:04:59 INFO - Running post-action listener: _start_resource_monitoring 03:04:59 INFO - Starting resource monitoring. 03:04:59 INFO - ##### 03:04:59 INFO - ##### Running install step. 03:04:59 INFO - ##### 03:04:59 INFO - Running pre-action listener: _resource_record_pre_action 03:04:59 INFO - Running main action method: install 03:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:04:59 INFO - Reading from file tmpfile_stdout 03:04:59 INFO - Detecting whether we're running mozinstall >=1.0... 03:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:04:59 INFO - Reading from file tmpfile_stdout 03:04:59 INFO - Output received: 03:04:59 INFO - Usage: mozinstall [options] installer 03:04:59 INFO - Options: 03:04:59 INFO - -h, --help show this help message and exit 03:04:59 INFO - -d DEST, --destination=DEST 03:04:59 INFO - Directory to install application into. [default: 03:04:59 INFO - "/builds/slave/test"] 03:04:59 INFO - --app=APP Application being installed. [default: firefox] 03:04:59 INFO - mkdir: /builds/slave/test/build/application 03:04:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:05:14 INFO - Reading from file tmpfile_stdout 03:05:14 INFO - Output received: 03:05:14 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:14 INFO - Running post-action listener: _resource_record_post_action 03:05:14 INFO - ##### 03:05:14 INFO - ##### Running run-tests step. 03:05:14 INFO - ##### 03:05:14 INFO - Running pre-action listener: _resource_record_pre_action 03:05:14 INFO - Running main action method: run_tests 03:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:14 INFO - Python 2.7.3 03:05:14 INFO - Return code: 0 03:05:14 INFO - grabbing minidump binary from tooltool 03:05:14 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')]} 03:05:14 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 0x230e0b0>, '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 0x230efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x230f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:14 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 03:05:14 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 03:05:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:14 INFO - Return code: 0 03:05:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:05:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:05:15 INFO - Return code: 0 03:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] in /builds/slave/test/build 03:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost 03:05:15 INFO - Using env: {'DISPLAY': ':0', 03:05:15 INFO - 'HOME': '/home/cltbld', 03:05:15 INFO - 'LANG': 'en_US.UTF-8', 03:05:15 INFO - 'LANGUAGE': 'en_US:en', 03:05:15 INFO - 'LOGNAME': 'cltbld', 03:05:15 INFO - 'MAIL': '/var/mail/cltbld', 03:05:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:15 INFO - 'MOZ_NO_REMOTE': '1', 03:05:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:15 INFO - 'NO_EM_RESTART': '1', 03:05:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:15 INFO - 'PWD': '/builds/slave/test', 03:05:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:15 INFO - 'SHELL': '/bin/bash', 03:05:15 INFO - 'SHLVL': '1', 03:05:15 INFO - 'TERM': 'linux', 03:05:15 INFO - 'TMOUT': '86400', 03:05:15 INFO - 'USER': 'cltbld', 03:05:15 INFO - 'XDG_SESSION_COOKIE': '004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203', 03:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:15 INFO - '_': '/tools/buildbot/bin/python'} 03:05:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost'] with output_timeout 3600 03:05:15 INFO - mozversion INFO | application_buildid: 20151209020345 03:05:15 INFO - mozversion INFO | application_changeset: 5211eaa88dca7f1105865edcc16aa29ef6a6f4b6 03:05:15 INFO - mozversion INFO | application_display_name: Nightly 03:05:15 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:15 INFO - mozversion INFO | application_name: Firefox 03:05:15 INFO - mozversion INFO | application_remotingname: firefox 03:05:15 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:05:15 INFO - mozversion INFO | application_vendor: Mozilla 03:05:15 INFO - mozversion INFO | application_version: 45.0a1 03:05:15 INFO - mozversion INFO | platform_buildid: 20151209020345 03:05:15 INFO - mozversion INFO | platform_changeset: 5211eaa88dca7f1105865edcc16aa29ef6a6f4b6 03:05:15 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:05:15 INFO - mozversion INFO | platform_version: 45.0a1 03:05:15 INFO - 2015-12-09 03:05:15,312 DEBUG : using testdate: 1449659115 03:05:15 INFO - 2015-12-09 03:05:15,312 DEBUG : actual date: 1449659115 03:05:15 INFO - 2015-12-09 03:05:15,321 INFO : starting webserver on 'localhost:41406' 03:05:15 INFO - 2015-12-09 03:05:15,322 INFO : Starting test suite talos-linux64-ix-066 03:05:15 INFO - 2015-12-09 03:05:15,322 INFO : Starting test dromaeo_css 03:05:15 INFO - 2015-12-09 03:05:15,322 DEBUG : operating with platform_type : linux_ 03:05:15 INFO - 2015-12-09 03:05:15,323 INFO : Initialising browser for dromaeo_css test... 03:05:15 INFO - 2015-12-09 03:05:15,337 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDh5iRO/profile http://localhost:41406/getInfo.html 03:05:20 INFO - 2015-12-09 03:05:20,044 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:05:20 INFO - 2015-12-09 03:05:20,044 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:05:20 INFO - 2015-12-09 03:05:20,044 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:05:20 INFO - 2015-12-09 03:05:20,044 DEBUG : BROWSER_OUTPUT: __metrics 03:05:20 INFO - 2015-12-09 03:05:20,153 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] 03:05:20 INFO - 2015-12-09 03:05:20,234 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] 03:05:21 INFO - 2015-12-09 03:05:21,505 INFO : Browser initialized. 03:05:21 INFO - 2015-12-09 03:05:21,506 INFO : Running cycle 1/1 for dromaeo_css test... 03:05:21 INFO - 2015-12-09 03:05:21,506 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDh5iRO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:05:33 INFO - 2015-12-09 03:05:33,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 03:05:33 INFO - 2015-12-09 03:05:33,433 DEBUG : BROWSER_OUTPUT: 03:06:25 INFO - 2015-12-09 03:06:25,162 DEBUG : BROWSER_OUTPUT: 1449659185160 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] 03:08:37 INFO - 2015-12-09 03:08:37,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41406/tests/dromaeo/cssquery-ext.html) 03:08:38 INFO - 2015-12-09 03:08:38,844 DEBUG : BROWSER_OUTPUT: RSS: Main: 238489600 03:08:38 INFO - 2015-12-09 03:08:38,844 DEBUG : BROWSER_OUTPUT: 03:11:41 INFO - 2015-12-09 03:11:41,253 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/dromaeo/cssquery-ext.html (next: http://localhost:41406/tests/dromaeo/cssquery-jquery.html) 03:11:41 INFO - 2015-12-09 03:11:41,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 224190464 03:11:41 INFO - 2015-12-09 03:11:41,835 DEBUG : BROWSER_OUTPUT: 03:14:43 INFO - 2015-12-09 03:14:43,888 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41406/tests/dromaeo/cssquery-mootools.html) 03:14:44 INFO - 2015-12-09 03:14:44,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 216014848 03:14:44 INFO - 2015-12-09 03:14:44,469 DEBUG : BROWSER_OUTPUT: 03:17:46 INFO - 2015-12-09 03:17:46,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41406/tests/dromaeo/cssquery-prototype.html) 03:17:46 INFO - 2015-12-09 03:17:46,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 203833344 03:17:46 INFO - 2015-12-09 03:17:46,929 DEBUG : BROWSER_OUTPUT: 03:20:49 INFO - 2015-12-09 03:20:49,664 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41406/tests/dromaeo/cssquery-yui.html) 03:20:50 INFO - 2015-12-09 03:20:50,246 DEBUG : BROWSER_OUTPUT: RSS: Main: 209096704 03:20:50 INFO - 2015-12-09 03:20:50,246 DEBUG : BROWSER_OUTPUT: 03:23:52 INFO - 2015-12-09 03:23:52,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/dromaeo/cssquery-yui.html (next: http://localhost:41406/tests/dromaeo/cssquery-dojo.html) 03:23:53 INFO - 2015-12-09 03:23:53,066 DEBUG : BROWSER_OUTPUT: RSS: Main: 252166144 03:23:53 INFO - 2015-12-09 03:23:53,066 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,066 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:23:53 INFO - 2015-12-09 03:23:53,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:23:53 INFO - 2015-12-09 03:23:53,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:23:53 INFO - 2015-12-09 03:23:53,067 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:23:53 INFO - 2015-12-09 03:23:53,068 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2612.882420291087;2727.1818454463682;2733.9316517087072;2737.055715778057;2759.2550011496896;4471.217536931041;4591.311303304506;4620.537946205382;4708.317293992373;4719.834805781798;4586.97706511467;4619.7921093550785;4684.859454216379;4708.717476951385;4736.265878788785;4304.332828411593;4351.108022855307;4375.1031038637;4377.080813029268;4386.298192289234;4146.170765846812;4428.6014258716705;4444.799984000728;4495.955040449603;4499.055198408339;4234.216669916044;4288.678349123797;4307.375430562583;4330.415393921811;4342.30523116303;4336.154449882274;4355.259605867011;4359.411479450266;4368.934465983013;4378.562143785596;4100.91798164038;4297.570242975708;4321.481422229321;4323.459567554056;4362.563743625644;4508.143452743968;4534.31985202219;4561.771911404449;4588.4035075440315;4617.12274667812;5045.823396181153;5093.414257360414;5101.591872650179;5104.617153713486;5154.123798954187;4868.683535570177;5121.308623335839;5121.769520371592;5122.1036318644465;5125.3080834087295;4622.791974361162;4628.791704373345;4638.2115040443205;4690.202665546865;4772;5179.663321884141;5187.896242075138;5202.739863006835;5210.192420174879;5245.449227831099;4763.69036012658;4965.47862474435;4989.775460104304;4990.3762029746285;5028.547430731252;4915.5330243626795;4932.457429682732;4934.284528743312;4938.407391113089;5062.9746851266245;4992.251162325608;4997.825076122318;5027.572656324181;5036.345275114285;5040.168372218616;4988.775505102279;5000.349954505891;5001.874953126128;5020.648554601216;5051.419086804991;4004.0590461241586;4054.412110243998;4084.183163367279;4234.13200293939;4274.850380236677;3579.0515513388973;3616.150204701893;3635.600083990759;3657.396529572644;3683.208110256308;4286.057067445157;4300.376445415397;4310.159518893785;4340.782960851945;4348.021695118637;4789.377380940456;4889.168841296988;4894.143524883131;5035.1188542005;5047.798088076436;4200.096979149497;4236.301010333322;4251.957480425156;4254.723442976197;4258.61672449481;4431.756253406029;4466.330050492452;4467.687261891637;4475.328700694857;4515.774211289422;4775.307580400822;4789.209780386197;4803.207470767285;4803.423589169182;4837.564619184361;4825.686330388514;4933.407991041098;4944.060628480577;4945.50544945517;5058.797648094035;4782;4801.51984801517;4802.711837289774;4805.927911081267;4830.686005409637;4980.551750342486;5012.598992080552;5018.874528136826;5030.0694371541385;5074.11203039474;4823.107725070873;4916.410030796184;4953.1579631463455;4963.602911767122;5044.344235249394;4892.486288939753;4904.92642610354;4914.213725803854;4921.114199444134;4961.231009193581;4902.166631672696;4903.068417000758;4916.459189489082;4916.631252655993;4948.15881300187;4628.259478483426;4736.336912832275;4763.69036012658;4770.069836381872;4883.926741098958;4958.975205124096;4963.230699241623;4973.925391119208;4977.328060711758;4980.228064649985;4851.927221091757;4853.830115945925;4857;4864.124457597666;4880.92678609814 03:23:53 INFO - 2015-12-09 03:23:53,072 DEBUG : BROWSER_OUTPUT: |1;ext.html;536.9409364969854;546.2352706211303;547.0535972767116;547.089096654071;547.8575570351708;26294.211173664797;26784.598231026503;26802.865985670094;26810.4637907242;26855.731442685566;27699.446011079766;35682;36428.271434571296;36582.26835463289;36618.63381366186;7884.05391353037;7920.089189743167;7925.3263472604895;7967.60161991901;8007.719729809458;7123;7329.19378868324;7696.846063078735;7786.065672119325;7805.5706936118495;7086.291370862924;7167.749128780494;7168;7173.10336207974;9876.753081172992;9912.107910288072;9954.402735835873;9999;10012.649557265533;10014.298999070032;9838.950805245999;9969.75075623108;10004.19966402686;10004.54979525923;10017.348872323275;36525.81737091324;37016.07459813526;37026.814865925495;37052.62947370519;37066.44400333997;2653.1112077454077;2701.122135306033;3039.8024128431803;3344.3980083584943;3360.059183428644;27270.727292727217;27498.17505474839;27960.16119516418;29876;30345.93228601843;3200.8239546824916;3227.5406180312098;3254.479283314682;3280.425925463034;3330.333933213367;208520;210707;210860;211279.94360028254;211424;54430.45569544333;54635.726821365635;54686.72656636692;54699;54796.45203547993;49723.254151187764;50543.74728126336;58997;60125.398746012856;60192.699036504535;12634.368281585885;12789.104762666524;12845.871541284467;12852.935735321264;12862.48550058006;9888.802223955481;9890.406575605486;9893.060159284856;9906.752331191634;9916.900830991597;18180.272789088554;18271.36050238235;18933.148008339656;19059.904700476687;19121;7502;7808.102068262109;7849.332806711379;7899.407544434191;7963.960180199062;776.2547953964257;851.7870532366908;873.3493547307297;928.7399528132133;948.4641177734558;26133.871523701662;26493.072742453922;26646.866765666047;26667.733322666914;26722.732772672025;902.4269588811152;924.6671198368582;956.9282303827241;980.9558569864373;1015.1168483419325;13748.587542373745;13863.722725545433;13902;13910.095843770123;13934.372953216927;247227;251583;251597;251758;251929;45020.77489612531;45493.77253113713;45526.77236613796;45551.544484555394;45578.316325255146;1040.6773900090996;1054.3410368519676;1068.5084860964043;1130.7851508213414;1202.3627477436971;19523.70714439256;27234.182974510797;27462.725372746016;27633.171004869888;27715.58426623562;42810.78594607007;42833.50082747089;43147.56852431435;43309.350359744;43330;225768;229521;234970;236246;236391;28381.716182837907;28916.27709307284;28935.421291574472;29268.70731292745;29367.11898643044;32505.674943250266;32911.50632740559;33554.32891342208;33574.66425335715;33598.83200583982;30306;31051.844740776152;37005.629943700216;38607;38795.61204388033;32775.18062048468;32989;33149.66850331466;33263.667363327026;33331.166720832174;32519.349613008082;33238.833805830815;33333.16667083342;33441.66558334483;33444.83277583597;27498.032652979524;29251.561226581194;29596.520173990782;29753.702462975958;29868.70131298659;23494.29517114489;24477;26149.60775588406;26615.656793415306;26850.865745671148 03:23:53 INFO - 2015-12-09 03:23:53,073 DEBUG : BROWSER_OUTPUT: |2;jquery.html;273.40397932507125;274.1460351006615;276.46641980976716;280.8890488257137;281.52281882209655;14878.553643390702;15129.167895765728;15270.23648817559;15271.694566108672;15498.767518487231;15739.685206295868;15752.84247157528;15777;15806;15991.920040399811;4731.739754313511;4757.976210118944;4848.2727590861305;4854.393200849894;4872.780724867372;4094.2425651254466;4858.611311095104;4860.222364421693;4870.342503762;4875.756212189394;3665.028767376634;3772.4152756322815;3773.9433908491396;5073.3404657394485;5078.669886457387;3732.9066773330615;3760.4923335349786;3764.6047165047685;3767.60440153784;6399.456046236076;5777.422257774231;5956.16613674086;5967.4629283364275;6393.7762178324;6393.881070812589;19489.220431182737;20585.485362865897;20735.79264207354;22376.88811555932;22395.664065039036;1620.991895040529;1636.4272504623286;1871.3356758350726;1920.7791104023077;1944.6499630066583;12993;13054.477820887154;13141.86858131416;13353.265570393625;13835.30823458833;1857.0807450312182;1860.2744929477515;1916.875403098794;1925.056722206123;1962.1856929374292;60561.6971915142;64483;64863.02705459469;65076;65108.348916511175;15207.31567079484;15592.142432166112;15672.373105075669;15683.843161568238;15697.764533532007;23319.883400582887;23478.413039674146;23557;23661.29016129519;23663.526729465313;8395.832083358298;8618.655253789904;8638.395312328203;8726.781830454163;8772.912270877338;7389.778306650809;7390.371818395389;7441.851162976818;7472.402207823361;7473.626318684044;7480.17718051014;7609.923900760921;7618;7623.199564045806;7628.160902300742;2929.4114709480714;2972.929745291693;2995.7753168512013;3015.517517197238;3017.713317234859;763.3702195688468;824.2993455562723;837.5267973594899;878.2622597018535;985.6500942165428;15585;16003.519894403187;16033.67932641364;16286.918565407334;16465;718.3175982816346;828.1842385250524;848.1560846957317;871.9084496127815;886.3175354976761;8470.49177049379;8785.604647790864;8819.911800882037;8896.777580560538;8949.463032218087;308490;309347;313150;313775;447118;50732.49267507352;57859.421405785404;62937;63436.68281658562;65624.6718766403;1005.1757558801712;1029.7425643589104;1034.803387356415;1038.8026275007724;1040.490159821697;14524.782128267872;14574.198419087052;14611.634709131931;14666.56000319992;15124.168170750714;32157;32896.83551582227;33281;33634.831825840716;33798.66201337955;43513.129737404444;46450.76774616105;47977.5202247987;48030.75984620055;48298.75850620725;8071.515709057476;8082.434229604107;8350.958245208734;8359.540225287668;8389.622466989122;9292.442453452815;9403.952980235055;9446.811063778823;9584.808303834025;9606.951965240129;9814.75463113428;14083.225422601856;14143.222122782934;14152.92923535417;14177.432902683777;13018;13836.584902452943;13897.305134743425;13986.790198146833;14036.578902632937;10633.89366106329;12238.388080595756;14199.787003194753;14385.64035899069;14506.709865802835;8066.475679080841;8692.39153259291;8865.778355541162;8866.202041816268;8876;13297.069205155933;13555.661108472366;13765.587032388643;13801.654958626115;14110.082844615066 03:23:53 INFO - 2015-12-09 03:23:53,075 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1385.854485279045;1588.4599236259671;1614.1848366574877;1640.425850952167;1653.776740140081;5907.320658124317;6665.333466653338;6832.350926661959;6839.11091558098;6849.417799487037;6827.249002609709;6934.098567186259;6944.5486043407145;6956.478264130185;6983.685734141963;1702.4296860551667;1740.7301868210448;1970.9211631534722;2014.4560968538522;2048.150017742635;2028.5030167608957;2028.5334373094197;2032.8881911494861;2035.613233485633;2036.4297996560986;2000.3398878370176;2005.6762536725764;2049.7950204979456;2050.3438899552148;2053.6816793397047;2018.5559176981042;2029.9289524866633;2045.98977005114;2057.3930690446355;2066.5556905265366;1955.511122219445;1976.980230197694;1978.5943881504256;1978.673518869385;1979.1192919150983;6957.339052789976;7029.332213439715;7034.929650703479;7035.824104397379;7043.154821421411;3997.2205419942834;4040.696947728932;4059.4316795648633;4075.7554546726997;4090.8159132839096;2458.5082983403213;2524.7222805491383;2550.5281522918135;2554.0294688018434;2559.1810620601414;768.7347864986626;787.5274835098952;805.267206841777;806.5523634382915;817.2930415190876;8921.286297096216;8926.86609700855;8942.776430589221;8943.463392196489;8948.821023579492;3571.964280357215;3624.5831729350934;3682;3694.07648087978;3708.8145592720257;7794.41541884361;7803.648835802403;7808;7819.3744500439825;7826;4053.9391909121387;4076.449679293317;4081.4490043843703;4085.6935729820384;4086.6730661547003;3725.2921944830937;3726.31063253299;3730;3731.1418373774186;3739.607341229186;2915.3003279213262;3006.5189569668746;3025.183200535843;3046.3602643444683;3340.615829179627;1032.1123833503182;1048.6067724603274;1054.1672079057612;1055.3193190392308;1057.7884423115408;911.266430523435;911.4759013567225;911.5988964855443;957.2724729205854;1041.3023274406166;6618.768343107968;6707.027481015225;6710.731570737214;6715.019069374546;6720;939.736873675372;940.8870935487786;971.5822196455592;1028.5063169678597;1033.452270296744;5198.168293073166;5235.947640523622;5252.789888404497;5261.789528418897;5262.947370526323;7778.22217778229;8066.677332906618;8116.8782468263025;8125.634346454423;8143.75568732939;8007.679692812222;8020.79948001293;8114.959425202955;8118.553479558681;8135.064467586303;6335.271443784024;6405.878971180025;6416.647084410309;6449.548531602836;6459.709313080923;6062.939370606237;6075.969620151871;6076.088586712029;6076.210092687922;6093.29927058394;7016.859662806817;7093.609851458219;7278.199398066103;7352.154502232098;7495.063117110361;6999.265077166824;7160.820979475555;7258.346748792634;7580.431467639839;7615.1242607098675;6005.189299444519;6090.299615544269;6092.2689277285235;6102.511799056154;6112.2970858351855;6229.53278504123;6372.203474565679;6388.936110638834;6393.584417012879;6589.769358072444;6127.264728232641;6185.659788711484;6268.874622507433;6315.336889626707;6366.64983425916;6108.419700128481;6112.572119951561;6206.410391012847;6208.689565521616;6254.437100660781;6211.192544969125;6227.906581401373;6311.968440157953;6313.116163736989;6324.209473815773;5632.408597097246;5655.095184770417;5674.375818659862;5683.175939488834;5691.26013618227;5867.911981320369;5915.911261330997;5916.763329466773;5917.526597872074;5924.407559244213 03:23:53 INFO - 2015-12-09 03:23:53,076 DEBUG : BROWSER_OUTPUT: |4;prototype.html;245.14078156063;249.0089444012829;249.94751102268512;251.7796927688273;253.07375007472655;5208.296879921209;5248.029114613794;5282.075636763566;5288.127458969266;5293.15309550472;5070.923936140961;5152;5216.478352164781;5221.817236396727;5315.202719592063;3998.120413509038;4031.516218053823;4040.3737420699763;4052.615001574846;4055.128147448298;3835.5013848199833;4049.676025917934;4053.9797301013455;4057.1479989202303;4057.452243947074;3875.2443273561667;3898.5126859142606;3943.152222272211;3953.6244056814558;3959.3467077932105;3942.8817135485983;3950.348192548226;3952.960470395288;3959.5644479107277;3967.3652215645357;3445.689887910075;3446.672566106216;3450.9827450862836;3452.4993875887853;3457.360388328167;5083.491650834924;5104.821331253388;5106.361704786902;5106.514881086291;5107.157319042353;4507.256302710049;4604;4605.930911036337;4610.077984403099;4614.884627884297;5558.249636299129;5571.192177134333;5578.553715702775;5582.63712858667;5588.273524441837;3761.0409345616968;3765.0775559987705;3769.1142581493327;3772.641599048086;3772.6604605585353;5922.466977972003;5931.347551769345;5931.822045338647;5932.495737862287;5937.70311484424;3765.134019175605;3859.2474467478573;3866.6906647468136;3873.1672690371706;3889.6110388961442;3879.2241551689776;3909.8045097745;3913.412988051815;3914.37370020801;3924.7252692311836;4522.321651752198;4528.275475923836;4577.793999269974;4578.58064000161;4578.793954272066;5611.354694210137;5623.100303951348;5624.859378515488;5625.8593535161945;5628.774849006076;1343.8790508854054;1355.4713661671956;1381.4336122189854;1383.370566392289;1383.889288856889;879.8078603492304;895.8790563274005;904.7828521155008;906.4833045164193;906.8981187856785;4831.782569784368;4856.781444834991;4858.319835223072;4861.611071114302;4864.246041863516;5760.049591817387;5766.192733017381;5769.249997500298;5772.220750198753;5791.391903850119;4713.787879545429;4811.230203167476;4842.95157048425;4853.514648535189;4865.391826021747;3151.7163455289133;3177.523371494294;3178.761592880543;3180.1890517918246;3188.7085730279273;5558;5558.138488534203;5558.471945165203;5560.860978475571;5561.054620714488;6058.303295121029;6059.757609695651;6061.575689701678;6064.3935606439;6065.2418447694035;5410.404855465896;5576.386597474275;5585.441455854463;5589;5589.077802162597;5902.527797776082;5914.260717410324;5915.349311575637;5920.082387229986;5923.763049477972;5799.82600521985;5801.274840644919;5806.896689628957;5806.970965145148;5813.04084825999;5415.079436495726;5563.610547261653;5575.470330318613;5587.8882422352135;5595.07681232592;3771.73597848148;3809.257194846978;3812.9618703813717;3813.9702280384695;3815.2369526094335;5909.70451477433;5914.822555323347;5916.201312822714;5922.082077278029;5923.141144533933;5679.290088738908;5691.174779657009;5692.51613612831;5695;5699.658020518782;5537.086380747131;5682.857928551819;5691.146328050825;5695.544356451391;5701.914471282851;5572.136318870419;5572.3034620672415;5574.665520068809;5576.470235327637;5576.581756368208;5732.05421105513;5735.971320143372;5736.741846616829;5738.971305143447;5743.10981797822;5440.564754819526;5587.860303492283;5591.021571224938;5591.10542313228;5593.664380137205 03:23:53 INFO - 2015-12-09 03:23:53,077 DEBUG : BROWSER_OUTPUT: |5;yui.html;793.853137169624;797.5493845977023;799.4124318625809;801.9759407217786;807.6728924785463;10568.682939511817;11034.613788517403;11081.722956926082;11084.833727494093;11108.722281942955;11791.941040294809;11872.347020913869;11887.049036077115;11893;11921.165518413714;612.3570251236206;620.0358442621722;621.0590954703628;769.3306823063929;787.1695361393728;616.3066550131102;623.2489849731086;779.4543819326466;790.8734602463607;799.188823344306;823.8928939237891;823.9176082391773;828.0766944856472;830.2030051150903;831.3723139030054;633.3887798274641;817.5094943034192;817.7138001699417;818.6561644109458;818.8567000774871;474.964377671676;604.8397174748695;614.6742226619854;615.6521565315583;615.9106929495198;11528.365939873387;11738.471768770425;11774.587889423829;11789.528418863236;11822.054235661126;10724.892751072468;11256.155788315828;11281.097512199087;11400.372979486125;12104.455299511543;9160.954195228982;9361.953190234006;9497.240220782322;9536.52317384135;9687.079727425884;3247.334296469242;3272.6563710810497;3310.6027276726704;3313.6520665330036;3323.401787678217;37786.43320350197;37877;37982;38020.23959520794;38070.42894356587;8913.643454261886;9391.765205869771;9449.385789923634;9477.336586439022;9523.666671666459;16025.919870400574;16128.112953787655;16151.757723634155;16161.757573636405;16166.919165404333;6076.149339092531;6103.115048317969;6220.533459990519;6232.781852635136;6234.750609975641;3435.089701229176;3449.3963556377535;3453.4129198035894;3459.056874303037;3599.8200089995394;2611.099170786076;2634.76287134155;2645.008121954267;2646.5897785843226;2652.7745141663177;450.0526391944909;450.9616385269965;457.44420529057356;458.80500787165323;462.02973755114664;508.7990243853657;529.1929807044212;555.0453220460801;578.887117012187;598.5839841310247;7383.778486645409;7493.85012299751;7591.810204744926;7707.152213256537;7727.188645192174;467.847949416441;503.5166240409248;519.929809475716;595.2826843653387;613.1018058544254;3713.9071523211596;3714.665680088751;3731.1231860512758;3760.4923335349927;3773.6792372648633;48443.51556484461;48816.26775598369;48956.02087958221;49064.26403603949;49109.75445122751;38544.80727596344;39258;48871.511284887405;49041.264381034314;49092.75453622709;39441;40554.1889162221;40589.79705101455;40733.59266407298;41001.17997640031;8027.638756255866;8062.193780621891;8082.313003394777;8088.150744171778;8383.245507904317;29303.85348073246;29511.704882950897;29715.851420742758;30078.699213008465;32333;38292.80853595714;38748;38815.417768734056;39365.21269574535;39384;9793.118619324296;9875.65435209793;9918.534519313904;9932.950335248277;10244.795104098026;11169.273997190157;11292.661220163409;11304.265222760494;11349.659510214708;11388.430578470878;10286.331388459726;10477.895221047693;10554.10290125348;10588.523516441624;10973.83539246896;10505.107065899485;10619.36283822973;10675.57297708083;10784.299020563638;11063;10452.32059916103;10465.319754215952;10595.682129536126;10623.150147988297;10763.300385474919;9214.493202873906;9347.579358928728;9458.43249405038;9570.377925434825;9619.989901060288;8815.559222039;8998.775030624287;9072.092790720875;9079.273658107204;9087.136722011399 03:23:53 INFO - 2015-12-09 03:23:53,077 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:23:53 INFO - 2015-12-09 03:23:53,077 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:23:53 INFO - 2015-12-09 03:23:53,077 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,880 03:23:53 INFO - 2015-12-09 03:23:53,077 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:23:53 INFO - 2015-12-09 03:23:53,077 DEBUG : BROWSER_OUTPUT: __startTimestamp1449660233065__endTimestamp 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4633.71 Median:4789.21 stddev:488.89 (10.2%) stddev-sans-first:463.98 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: Values: 2612.9 2727.2 2733.9 2737.1 2759.3 4471.2 4591.3 4620.5 4708.3 4719.8 4587.0 4619.8 4684.9 4708.7 4736.3 4304.3 4351.1 4375.1 4377.1 4386.3 4146.2 4428.6 4444.8 4496.0 4499.1 4234.2 4288.7 4307.4 4330.4 4342.3 4336.2 4355.3 4359.4 4368.9 4378.6 4100.9 4297.6 4321.5 4323.5 4362.6 4508.1 4534.3 4561.8 4588.4 4617.1 5045.8 5093.4 5101.6 5104.6 5154.1 4868.7 5121.3 5121.8 5122.1 5125.3 4622.8 4628.8 4638.2 4690.2 4772.0 5179.7 5187.9 5202.7 5210.2 5245.4 4763.7 4965.5 4989.8 4990.4 5028.5 4915.5 4932.5 4934.3 4938.4 5063.0 4992.3 4997.8 5027.6 5036.3 5040.2 4988.8 5000.3 5001.9 5020.6 5051.4 4004.1 4054.4 4084.2 4234.1 4274.9 3579.1 3616.2 3635.6 3657.4 3683.2 4286.1 4300.4 4310.2 4340.8 4348.0 4789.4 4889.2 4894.1 5035.1 5047.8 4200.1 4236.3 4252.0 4254.7 4258.6 4431.8 4466.3 4467.7 4475.3 4515.8 4775.3 4789.2 4803.2 4803.4 4837.6 4825.7 4933.4 4944.1 4945.5 5058.8 4782.0 4801.5 4802.7 4805.9 4830.7 4980.6 5012.6 5018.9 5030.1 5074.1 4823.1 4916.4 4953.2 4963.6 5044.3 4892.5 4904.9 4914.2 4921.1 4961.2 4902.2 4903.1 4916.5 4916.6 4948.2 4628.3 4736.3 4763.7 4770.1 4883.9 4959.0 4963.2 4973.9 4977.3 4980.2 4851.9 4853.8 4857.0 4864.1 4880.9 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39073.96 Median:33069.33 stddev:60285.64 (182.3%) stddev-sans-first:60385.31 03:23:53 INFO - 2015-12-09 03:23:53,078 DEBUG : BROWSER_OUTPUT: Values: 536.9 546.2 547.1 547.1 547.9 26294.2 26784.6 26802.9 26810.5 26855.7 27699.4 35682.0 36428.3 36582.3 36618.6 7884.1 7920.1 7925.3 7967.6 8007.7 7123.0 7329.2 7696.8 7786.1 7805.6 7086.3 7167.7 7168.0 7173.1 9876.8 9912.1 9954.4 9999.0 10012.6 10014.3 9839.0 9969.8 10004.2 10004.5 10017.3 36525.8 37016.1 37026.8 37052.6 37066.4 2653.1 2701.1 3039.8 3344.4 3360.1 27270.7 27498.2 27960.2 29876.0 30345.9 3200.8 3227.5 3254.5 3280.4 3330.3 208520.0 210707.0 210860.0 211279.9 211424.0 54430.5 54635.7 54686.7 54699.0 54796.5 49723.3 50543.7 58997.0 60125.4 60192.7 12634.4 12789.1 12845.9 12852.9 12862.5 9888.8 9890.4 9893.1 9906.8 9916.9 18180.3 18271.4 18933.1 19059.9 19121.0 7502.0 7808.1 7849.3 7899.4 7964.0 776.3 851.8 873.3 928.7 948.5 26133.9 26493.1 26646.9 26667.7 26722.7 902.4 924.7 956.9 981.0 1015.1 13748.6 13863.7 13902.0 13910.1 13934.4 247227.0 251583.0 251597.0 251758.0 251929.0 45020.8 45493.8 45526.8 45551.5 45578.3 1040.7 1054.3 1068.5 1130.8 1202.4 19523.7 27234.2 27462.7 27633.2 27715.6 42810.8 42833.5 43147.6 43309.4 43330.0 225768.0 229521.0 234970.0 236246.0 236391.0 28381.7 28916.3 28935.4 29268.7 29367.1 32505.7 32911.5 33554.3 33574.7 33598.8 30306.0 31051.8 37005.6 38607.0 38795.6 32775.2 32989.0 33149.7 33263.7 33331.2 32519.3 33238.8 33333.2 33441.7 33444.8 27498.0 29251.6 29596.5 29753.7 29868.7 23494.3 24477.0 26149.6 26615.7 26850.9 03:23:53 INFO - 2015-12-09 03:23:53,079 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,079 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22901.18 Median:33457.92 stddev:56272.96 (168.2%) stddev-sans-first:56405.18 03:23:53 INFO - 2015-12-09 03:23:53,080 DEBUG : BROWSER_OUTPUT: Values: 273.4 274.1 276.5 280.9 281.5 14878.6 15129.2 15270.2 15271.7 15498.8 15739.7 15752.8 15777.0 15806.0 15991.9 4731.7 4758.0 4848.3 4854.4 4872.8 4094.2 4858.6 4860.2 4870.3 4875.8 3665.0 3772.4 3773.9 5073.3 5078.7 3732.9 3760.5 3764.6 3767.6 6399.5 5777.4 5956.2 5967.5 6393.8 6393.9 19489.2 20585.5 20735.8 22376.9 22395.7 1621.0 1636.4 1871.3 1920.8 1944.6 12993.0 13054.5 13141.9 13353.3 13835.3 1857.1 1860.3 1916.9 1925.1 1962.2 60561.7 64483.0 64863.0 65076.0 65108.3 15207.3 15592.1 15672.4 15683.8 15697.8 23319.9 23478.4 23557.0 23661.3 23663.5 8395.8 8618.7 8638.4 8726.8 8772.9 7389.8 7390.4 7441.9 7472.4 7473.6 7480.2 7609.9 7618.0 7623.2 7628.2 2929.4 2972.9 2995.8 3015.5 3017.7 763.4 824.3 837.5 878.3 985.7 15585.0 16003.5 16033.7 16286.9 16465.0 718.3 828.2 848.2 871.9 886.3 8470.5 8785.6 8819.9 8896.8 8949.5 308490.0 309347.0 313150.0 313775.0 447118.0 50732.5 57859.4 62937.0 63436.7 65624.7 1005.2 1029.7 1034.8 1038.8 1040.5 14524.8 14574.2 14611.6 14666.6 15124.2 32157.0 32896.8 33281.0 33634.8 33798.7 43513.1 46450.8 47977.5 48030.8 48298.8 8071.5 8082.4 8351.0 8359.5 8389.6 9292.4 9404.0 9446.8 9584.8 9607.0 9814.8 14083.2 14143.2 14152.9 14177.4 13018.0 13836.6 13897.3 13986.8 14036.6 10633.9 12238.4 14199.8 14385.6 14506.7 8066.5 8692.4 8865.8 8866.2 8876.0 13297.1 13555.7 13765.6 13801.7 14110.1 03:23:53 INFO - 2015-12-09 03:23:53,080 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,080 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4767.76 Median:6092.78 stddev:2446.07 (40.1%) stddev-sans-first:2439.73 03:23:53 INFO - 2015-12-09 03:23:53,080 DEBUG : BROWSER_OUTPUT: Values: 1385.9 1588.5 1614.2 1640.4 1653.8 5907.3 6665.3 6832.4 6839.1 6849.4 6827.2 6934.1 6944.5 6956.5 6983.7 1702.4 1740.7 1970.9 2014.5 2048.2 2028.5 2028.5 2032.9 2035.6 2036.4 2000.3 2005.7 2049.8 2050.3 2053.7 2018.6 2029.9 2046.0 2057.4 2066.6 1955.5 1977.0 1978.6 1978.7 1979.1 6957.3 7029.3 7034.9 7035.8 7043.2 3997.2 4040.7 4059.4 4075.8 4090.8 2458.5 2524.7 2550.5 2554.0 2559.2 768.7 787.5 805.3 806.6 817.3 8921.3 8926.9 8942.8 8943.5 8948.8 3572.0 3624.6 3682.0 3694.1 3708.8 7794.4 7803.6 7808.0 7819.4 7826.0 4053.9 4076.4 4081.4 4085.7 4086.7 3725.3 3726.3 3730.0 3731.1 3739.6 2915.3 3006.5 3025.2 3046.4 3340.6 1032.1 1048.6 1054.2 1055.3 1057.8 911.3 911.5 911.6 957.3 1041.3 6618.8 6707.0 6710.7 6715.0 6720.0 939.7 940.9 971.6 1028.5 1033.5 5198.2 5235.9 5252.8 5261.8 5262.9 7778.2 8066.7 8116.9 8125.6 8143.8 8007.7 8020.8 8115.0 8118.6 8135.1 6335.3 6405.9 6416.6 6449.5 6459.7 6062.9 6076.0 6076.1 6076.2 6093.3 7016.9 7093.6 7278.2 7352.2 7495.1 6999.3 7160.8 7258.3 7580.4 7615.1 6005.2 6090.3 6092.3 6102.5 6112.3 6229.5 6372.2 6388.9 6393.6 6589.8 6127.3 6185.7 6268.9 6315.3 6366.6 6108.4 6112.6 6206.4 6208.7 6254.4 6211.2 6227.9 6312.0 6313.1 6324.2 5632.4 5655.1 5674.4 5683.2 5691.3 5867.9 5915.9 5916.8 5917.5 5924.4 03:23:53 INFO - 2015-12-09 03:23:53,081 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,081 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4618.48 Median:5265.05 stddev:1417.23 (26.9%) stddev-sans-first:1382.67 03:23:53 INFO - 2015-12-09 03:23:53,081 DEBUG : BROWSER_OUTPUT: Values: 245.1 249.0 249.9 251.8 253.1 5208.3 5248.0 5282.1 5288.1 5293.2 5070.9 5152.0 5216.5 5221.8 5315.2 3998.1 4031.5 4040.4 4052.6 4055.1 3835.5 4049.7 4054.0 4057.1 4057.5 3875.2 3898.5 3943.2 3953.6 3959.3 3942.9 3950.3 3953.0 3959.6 3967.4 3445.7 3446.7 3451.0 3452.5 3457.4 5083.5 5104.8 5106.4 5106.5 5107.2 4507.3 4604.0 4605.9 4610.1 4614.9 5558.2 5571.2 5578.6 5582.6 5588.3 3761.0 3765.1 3769.1 3772.6 3772.7 5922.5 5931.3 5931.8 5932.5 5937.7 3765.1 3859.2 3866.7 3873.2 3889.6 3879.2 3909.8 3913.4 3914.4 3924.7 4522.3 4528.3 4577.8 4578.6 4578.8 5611.4 5623.1 5624.9 5625.9 5628.8 1343.9 1355.5 1381.4 1383.4 1383.9 879.8 895.9 904.8 906.5 906.9 4831.8 4856.8 4858.3 4861.6 4864.2 5760.0 5766.2 5769.2 5772.2 5791.4 4713.8 4811.2 4843.0 4853.5 4865.4 3151.7 3177.5 3178.8 3180.2 3188.7 5558.0 5558.1 5558.5 5560.9 5561.1 6058.3 6059.8 6061.6 6064.4 6065.2 5410.4 5576.4 5585.4 5589.0 5589.1 5902.5 5914.3 5915.3 5920.1 5923.8 5799.8 5801.3 5806.9 5807.0 5813.0 5415.1 5563.6 5575.5 5587.9 5595.1 3771.7 3809.3 3813.0 3814.0 3815.2 5909.7 5914.8 5916.2 5922.1 5923.1 5679.3 5691.2 5692.5 5695.0 5699.7 5537.1 5682.9 5691.1 5695.5 5701.9 5572.1 5572.3 5574.7 5576.5 5576.6 5732.1 5736.0 5736.7 5739.0 5743.1 5440.6 5587.9 5591.0 5591.1 5593.7 03:23:53 INFO - 2015-12-09 03:23:53,081 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,081 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12077.57 Median:458.12 stddev:13577.96 (2963.8%) stddev-sans-first:13589.61 03:23:53 INFO - 2015-12-09 03:23:53,082 DEBUG : BROWSER_OUTPUT: Values: 793.9 797.5 799.4 802.0 807.7 10568.7 11034.6 11081.7 11084.8 11108.7 11791.9 11872.3 11887.0 11893.0 11921.2 612.4 620.0 621.1 769.3 787.2 616.3 623.2 779.5 790.9 799.2 823.9 823.9 828.1 830.2 831.4 633.4 817.5 817.7 818.7 818.9 475.0 604.8 614.7 615.7 615.9 11528.4 11738.5 11774.6 11789.5 11822.1 10724.9 11256.2 11281.1 11400.4 12104.5 9161.0 9362.0 9497.2 9536.5 9687.1 3247.3 3272.7 3310.6 3313.7 3323.4 37786.4 37877.0 37982.0 38020.2 38070.4 8913.6 9391.8 9449.4 9477.3 9523.7 16025.9 16128.1 16151.8 16161.8 16166.9 6076.1 6103.1 6220.5 6232.8 6234.8 3435.1 3449.4 3453.4 3459.1 3599.8 2611.1 2634.8 2645.0 2646.6 2652.8 450.1 451.0 457.4 458.8 462.0 508.8 529.2 555.0 578.9 598.6 7383.8 7493.9 7591.8 7707.2 7727.2 467.8 503.5 519.9 595.3 613.1 3713.9 3714.7 3731.1 3760.5 3773.7 48443.5 48816.3 48956.0 49064.3 49109.8 38544.8 39258.0 48871.5 49041.3 49092.8 39441.0 40554.2 40589.8 40733.6 41001.2 8027.6 8062.2 8082.3 8088.2 8383.2 29303.9 29511.7 29715.9 30078.7 32333.0 38292.8 38748.0 38815.4 39365.2 39384.0 9793.1 9875.7 9918.5 9933.0 10244.8 11169.3 11292.7 11304.3 11349.7 11388.4 10286.3 10477.9 10554.1 10588.5 10973.8 10505.1 10619.4 10675.6 10784.3 11063.0 10452.3 10465.3 10595.7 10623.2 10763.3 9214.5 9347.6 9458.4 9570.4 9620.0 8815.6 8998.8 9072.1 9079.3 9087.1 03:23:53 INFO - 2015-12-09 03:23:53,082 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:23:53 INFO - 2015-12-09 03:23:53,082 DEBUG : BROWSER_OUTPUT: 03:23:53 INFO - 2015-12-09 03:23:53,775 INFO : Browser exited with error code: 0 03:23:53 INFO - 2015-12-09 03:23:53,798 INFO : Completed test dromaeo_css (00:18:38) 03:23:53 INFO - 2015-12-09 03:23:53,799 INFO : Starting test kraken 03:23:53 INFO - 2015-12-09 03:23:53,799 DEBUG : operating with platform_type : linux_ 03:23:53 INFO - 2015-12-09 03:23:53,799 INFO : Initialising browser for kraken test... 03:23:53 INFO - 2015-12-09 03:23:53,805 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOTD4XZ/profile http://localhost:41406/getInfo.html 03:23:58 INFO - 2015-12-09 03:23:58,310 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:23:58 INFO - 2015-12-09 03:23:58,311 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:23:58 INFO - 2015-12-09 03:23:58,311 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:23:58 INFO - 2015-12-09 03:23:58,311 DEBUG : BROWSER_OUTPUT: __metrics 03:23:58 INFO - 2015-12-09 03:23:58,392 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] 03:23:58 INFO - 2015-12-09 03:23:58,448 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] 03:23:58 ERROR - 2015-12-09 03:23:58,455 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 03:23:59 INFO - 2015-12-09 03:23:59,325 INFO : Browser initialized. 03:23:59 INFO - 2015-12-09 03:23:59,326 INFO : Running cycle 1/1 for kraken test... 03:23:59 INFO - 2015-12-09 03:23:59,326 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOTD4XZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:24:11 INFO - 2015-12-09 03:24:11,364 DEBUG : BROWSER_OUTPUT: RSS: Main: 143126528 03:24:11 INFO - 2015-12-09 03:24:11,364 DEBUG : BROWSER_OUTPUT: 03:24:14 INFO - 2015-12-09 03:24:14,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41406/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:14 INFO - 2015-12-09 03:24:14,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 176386048 03:24:14 INFO - 2015-12-09 03:24:14,591 DEBUG : BROWSER_OUTPUT: 03:24:17 INFO - 2015-12-09 03:24:17,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41406/tests/kraken/driver.html?testName=audio-dft) 03:24:17 INFO - 2015-12-09 03:24:17,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 167493632 03:24:17 INFO - 2015-12-09 03:24:17,921 DEBUG : BROWSER_OUTPUT: 03:24:20 INFO - 2015-12-09 03:24:20,941 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41406/tests/kraken/driver.html?testName=audio-fft) 03:24:21 INFO - 2015-12-09 03:24:21,506 DEBUG : BROWSER_OUTPUT: RSS: Main: 153640960 03:24:21 INFO - 2015-12-09 03:24:21,506 DEBUG : BROWSER_OUTPUT: 03:24:23 INFO - 2015-12-09 03:24:23,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41406/tests/kraken/driver.html?testName=audio-oscillator) 03:24:24 INFO - 2015-12-09 03:24:24,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 155414528 03:24:24 INFO - 2015-12-09 03:24:24,096 DEBUG : BROWSER_OUTPUT: 03:24:26 INFO - 2015-12-09 03:24:26,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41406/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:26 INFO - 2015-12-09 03:24:26,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 157863936 03:24:26 INFO - 2015-12-09 03:24:26,907 DEBUG : BROWSER_OUTPUT: 03:24:29 INFO - 2015-12-09 03:24:29,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41406/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:30 INFO - 2015-12-09 03:24:30,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 156745728 03:24:30 INFO - 2015-12-09 03:24:30,479 DEBUG : BROWSER_OUTPUT: 03:24:33 INFO - 2015-12-09 03:24:33,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41406/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:34 INFO - 2015-12-09 03:24:34,463 DEBUG : BROWSER_OUTPUT: RSS: Main: 158531584 03:24:34 INFO - 2015-12-09 03:24:34,464 DEBUG : BROWSER_OUTPUT: 03:24:37 INFO - 2015-12-09 03:24:37,342 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41406/tests/kraken/driver.html?testName=json-parse-financial) 03:24:37 INFO - 2015-12-09 03:24:37,923 DEBUG : BROWSER_OUTPUT: RSS: Main: 157896704 03:24:37 INFO - 2015-12-09 03:24:37,923 DEBUG : BROWSER_OUTPUT: 03:24:39 INFO - 2015-12-09 03:24:39,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41406/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:24:40 INFO - 2015-12-09 03:24:40,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 167907328 03:24:40 INFO - 2015-12-09 03:24:40,291 DEBUG : BROWSER_OUTPUT: 03:24:42 INFO - 2015-12-09 03:24:42,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:24:42 INFO - 2015-12-09 03:24:42,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 167251968 03:24:42 INFO - 2015-12-09 03:24:42,763 DEBUG : BROWSER_OUTPUT: 03:24:44 INFO - 2015-12-09 03:24:44,915 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:24:45 INFO - 2015-12-09 03:24:45,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 180355072 03:24:45 INFO - 2015-12-09 03:24:45,501 DEBUG : BROWSER_OUTPUT: 03:24:48 INFO - 2015-12-09 03:24:48,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:24:48 INFO - 2015-12-09 03:24:48,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 184102912 03:24:48 INFO - 2015-12-09 03:24:48,614 DEBUG : BROWSER_OUTPUT: 03:24:51 INFO - 2015-12-09 03:24:51,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:24:51 INFO - 2015-12-09 03:24:51,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 182882304 03:24:51 INFO - 2015-12-09 03:24:51,763 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41406/tests/kraken/driver.html?testName=ai-astar) 03:24:53 INFO - 2015-12-09 03:24:53,768 DEBUG : BROWSER_OUTPUT: RSS: Main: 241573888 03:24:53 INFO - 2015-12-09 03:24:53,769 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,772 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:24:53 INFO - 2015-12-09 03:24:53,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:24:53 INFO - 2015-12-09 03:24:53,772 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:24:53 INFO - 2015-12-09 03:24:53,772 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;113;106;113;113;113;101;115;111;106 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;154;175;129;152;161;134;171;128 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;162;160;161;160;161;163;164;162 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;87;94;74;73;72;108;87;74 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;130;94;95;95;136;93;95;129 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;109;110 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;147;147;147;147;146;147;146 03:24:53 INFO - 2015-12-09 03:24:53,773 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;73;72;72;72;72;71;71;70 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;69;68;68;68;68;69;69;68 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;86;85;92;84;85;85;84;85 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;125;125;123;124;120;118;122;129;130 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;138;147;146;152;135;150;147;146;133 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;71;70;68;70;68;69;72;70;68 03:24:53 INFO - 2015-12-09 03:24:53,774 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:24:53 INFO - 2015-12-09 03:24:53,775 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:24:53 INFO - 2015-12-09 03:24:53,775 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,979 03:24:53 INFO - 2015-12-09 03:24:53,775 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:24:53 INFO - 2015-12-09 03:24:53,775 DEBUG : BROWSER_OUTPUT: __startTimestamp1449660293771__endTimestamp 03:24:53 INFO - 2015-12-09 03:24:53,775 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.10 Median:113.00 stddev:4.41 (3.9%) stddev-sans-first:4.68 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: Values: 110.0 113.0 106.0 113.0 113.0 113.0 101.0 115.0 111.0 106.0 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.00 Median:155.00 stddev:17.68 (11.4%) stddev-sans-first:18.57 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 154.0 175.0 129.0 152.0 161.0 134.0 171.0 128.0 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,783 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 162.0 160.0 161.0 160.0 161.0 163.0 164.0 162.0 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.30 Median:74.00 stddev:12.36 (16.7%) stddev-sans-first:12.64 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 87.0 94.0 74.0 73.0 72.0 108.0 87.0 74.0 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:94.50 stddev:18.09 (19.1%) stddev-sans-first:18.69 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 130.0 94.0 95.0 95.0 136.0 93.0 95.0 129.0 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:24:53 INFO - 2015-12-09 03:24:53,784 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.50 Median:72.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 73.0 72.0 72.0 72.0 72.0 71.0 71.0 70.0 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 69.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 03:24:53 INFO - 2015-12-09 03:24:53,785 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.44 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 86.0 85.0 92.0 84.0 85.0 85.0 84.0 85.0 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:124.50 stddev:3.86 (3.1%) stddev-sans-first:3.87 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: Values: 120.0 125.0 125.0 123.0 124.0 120.0 118.0 122.0 129.0 130.0 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:146.50 stddev:6.82 (4.7%) stddev-sans-first:6.74 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: Values: 136.0 138.0 147.0 146.0 152.0 135.0 150.0 147.0 146.0 133.0 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:70.00 stddev:1.43 (2.0%) stddev-sans-first:1.42 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 70.0 68.0 70.0 68.0 69.0 72.0 70.0 68.0 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:24:53 INFO - 2015-12-09 03:24:53,786 DEBUG : BROWSER_OUTPUT: 03:24:54 INFO - 2015-12-09 03:24:54,683 INFO : Browser exited with error code: 0 03:24:54 INFO - 2015-12-09 03:24:54,733 INFO : Completed test kraken (00:01:00) 03:24:54 INFO - 2015-12-09 03:24:54,733 INFO : Starting test v8_7 03:24:54 INFO - 2015-12-09 03:24:54,733 DEBUG : operating with platform_type : linux_ 03:24:54 INFO - 2015-12-09 03:24:54,734 INFO : Initialising browser for v8_7 test... 03:24:54 INFO - 2015-12-09 03:24:54,740 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRo8LV1/profile http://localhost:41406/getInfo.html 03:24:58 INFO - 2015-12-09 03:24:58,919 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:24:58 INFO - 2015-12-09 03:24:58,919 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:24:58 INFO - 2015-12-09 03:24:58,919 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:24:58 INFO - 2015-12-09 03:24:58,919 DEBUG : BROWSER_OUTPUT: __metrics 03:24:59 INFO - 2015-12-09 03:24:59,024 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] 03:24:59 INFO - 2015-12-09 03:24:59,086 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] 03:25:00 INFO - 2015-12-09 03:25:00,260 INFO : Browser initialized. 03:25:00 INFO - 2015-12-09 03:25:00,260 INFO : Running cycle 1/1 for v8_7 test... 03:25:00 INFO - 2015-12-09 03:25:00,260 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRo8LV1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:25:12 INFO - 2015-12-09 03:25:12,277 DEBUG : BROWSER_OUTPUT: RSS: Main: 142999552 03:25:12 INFO - 2015-12-09 03:25:12,277 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41406/tests/v8_7/run.html (next: http://localhost:41406/tests/v8_7/run.html) 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 452943872 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: |0;Richards;166.14055490945339 03:25:33 INFO - 2015-12-09 03:25:33,966 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.28912071535024 03:25:33 INFO - 2015-12-09 03:25:33,967 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.700638711469 03:25:33 INFO - 2015-12-09 03:25:33,967 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5170.103092783505 03:25:33 INFO - 2015-12-09 03:25:33,967 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 03:25:33 INFO - 2015-12-09 03:25:33,967 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 03:25:33 INFO - 2015-12-09 03:25:33,967 DEBUG : BROWSER_OUTPUT: |6;Boyer;12292.682926829268 03:25:33 INFO - 2015-12-09 03:25:33,967 DEBUG : BROWSER_OUTPUT: |7;RegExp;27432.432432432433 03:25:33 INFO - 2015-12-09 03:25:33,968 DEBUG : BROWSER_OUTPUT: |8;Splay;741.2898443291327 03:25:33 INFO - 2015-12-09 03:25:33,968 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 03:25:33 INFO - 2015-12-09 03:25:33,968 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:25:33 INFO - 2015-12-09 03:25:33,968 DEBUG : BROWSER_OUTPUT: __startTimestamp1449660333964__endTimestamp 03:25:33 INFO - 2015-12-09 03:25:33,968 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,968 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:25:33 INFO - 2015-12-09 03:25:33,969 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:25:33 INFO - 2015-12-09 03:25:33,969 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,969 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,969 DEBUG : BROWSER_OUTPUT: Values: 166.1 03:25:33 INFO - 2015-12-09 03:25:33,969 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,970 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.29 Median:186.29 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,970 DEBUG : BROWSER_OUTPUT: Values: 186.3 03:25:33 INFO - 2015-12-09 03:25:33,970 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,970 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,970 DEBUG : BROWSER_OUTPUT: Values: 277.7 03:25:33 INFO - 2015-12-09 03:25:33,970 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: Values: 5170.1 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: Values: 1992.0 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: Values: 784.3 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,972 DEBUG : BROWSER_OUTPUT: Values: 12292.7 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27432.43 Median:27432.43 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: Values: 27432.4 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:741.29 Median:741.29 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: Values: 741.3 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: Values: 4830.9 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:25:33 INFO - 2015-12-09 03:25:33,973 DEBUG : BROWSER_OUTPUT: 03:25:34 INFO - 2015-12-09 03:25:34,819 INFO : Browser exited with error code: 0 03:25:34 INFO - 2015-12-09 03:25:34,836 INFO : Completed test v8_7 (00:00:40) 03:25:34 INFO - 2015-12-09 03:25:34,987 INFO : Completed test suite (00:20:19) 03:25:34 INFO - 2015-12-09 03:25:34,987 DEBUG : Working with test: dromaeo_css 03:25:34 INFO - 2015-12-09 03:25:34,987 DEBUG : Generating results file: dromaeo_css 03:25:34 INFO - 2015-12-09 03:25:34,988 DEBUG : Working with test: kraken 03:25:34 INFO - 2015-12-09 03:25:34,988 DEBUG : Generating results file: kraken 03:25:34 INFO - 2015-12-09 03:25:34,989 INFO : javascript benchmark 03:25:34 INFO - 2015-12-09 03:25:34,989 DEBUG : Working with test: v8_7 03:25:34 INFO - 2015-12-09 03:25:34,989 DEBUG : Generating results file: v8_7 03:25:34 INFO - 2015-12-09 03:25:34,989 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:25:35 INFO - 2015-12-09 03:25:35,044 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:25:35 INFO - 2015-12-09 03:25:35,044 DEBUG : process_Request line: dromaeo_css 6263.80 graph.html#tests=[[72,132,35]] 03:25:35 INFO - 2015-12-09 03:25:35,044 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:25:35 INFO - 2015-12-09 03:25:35,077 DEBUG : process_Request line: kraken 1520.20 graph.html#tests=[[232,132,35]] 03:25:35 INFO - 2015-12-09 03:25:35,077 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:25:35 INFO - 2015-12-09 03:25:35,217 DEBUG : process_Request line: v8_7 19370.47 graph.html#tests=[[230,132,35]] 03:25:35 INFO - 2015-12-09 03:25:35,218 INFO : javascript benchmark 03:25:35 INFO - 2015-12-09 03:25:35,222 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2612.882420291087, 2727.1818454463682, 2733.9316517087072, 2737.055715778057, 2759.2550011496896, 4471.217536931041, 4591.311303304506, 4620.537946205382, 4708.317293992373, 4719.834805781798, 4586.97706511467, 4619.7921093550785, 4684.859454216379, 4708.717476951385, 4736.265878788785, 4304.332828411593, 4351.108022855307, 4375.1031038637, 4377.080813029268, 4386.298192289234, 4146.170765846812, 4428.6014258716705, 4444.799984000728, 4495.955040449603, 4499.055198408339, 4234.216669916044, 4288.678349123797, 4307.375430562583, 4330.415393921811, 4342.30523116303, 4336.154449882274, 4355.259605867011, 4359.411479450266, 4368.934465983013, 4378.562143785596, 4100.91798164038, 4297.570242975708, 4321.481422229321, 4323.459567554056, 4362.563743625644, 4508.143452743968, 4534.31985202219, 4561.771911404449, 4588.4035075440315, 4617.12274667812, 5045.823396181153, 5093.414257360414, 5101.591872650179, 5104.617153713486, 5154.123798954187, 4868.683535570177, 5121.308623335839, 5121.769520371592, 5122.1036318644465, 5125.3080834087295, 4622.791974361162, 4628.791704373345, 4638.2115040443205, 4690.202665546865, 4772.0, 5179.663321884141, 5187.896242075138, 5202.739863006835, 5210.192420174879, 5245.449227831099, 4763.69036012658, 4965.47862474435, 4989.775460104304, 4990.3762029746285, 5028.547430731252, 4915.5330243626795, 4932.457429682732, 4934.284528743312, 4938.407391113089, 5062.9746851266245, 4992.251162325608, 4997.825076122318, 5027.572656324181, 5036.345275114285, 5040.168372218616, 4988.775505102279, 5000.349954505891, 5001.874953126128, 5020.648554601216, 5051.419086804991, 4004.0590461241586, 4054.412110243998, 4084.183163367279, 4234.13200293939, 4274.850380236677, 3579.0515513388973, 3616.150204701893, 3635.600083990759, 3657.396529572644, 3683.208110256308, 4286.057067445157, 4300.376445415397, 4310.159518893785, 4340.782960851945, 4348.021695118637, 4789.377380940456, 4889.168841296988, 4894.143524883131, 5035.1188542005, 5047.798088076436, 4200.096979149497, 4236.301010333322, 4251.957480425156, 4254.723442976197, 4258.61672449481, 4431.756253406029, 4466.330050492452, 4467.687261891637, 4475.328700694857, 4515.774211289422, 4775.307580400822, 4789.209780386197, 4803.207470767285, 4803.423589169182, 4837.564619184361, 4825.686330388514, 4933.407991041098, 4944.060628480577, 4945.50544945517, 5058.797648094035, 4782.0, 4801.51984801517, 4802.711837289774, 4805.927911081267, 4830.686005409637, 4980.551750342486, 5012.598992080552, 5018.874528136826, 5030.0694371541385, 5074.11203039474, 4823.107725070873, 4916.410030796184, 4953.1579631463455, 4963.602911767122, 5044.344235249394, 4892.486288939753, 4904.92642610354, 4914.213725803854, 4921.114199444134, 4961.231009193581, 4902.166631672696, 4903.068417000758, 4916.459189489082, 4916.631252655993, 4948.15881300187, 4628.259478483426, 4736.336912832275, 4763.69036012658, 4770.069836381872, 4883.926741098958, 4958.975205124096, 4963.230699241623, 4973.925391119208, 4977.328060711758, 4980.228064649985, 4851.927221091757, 4853.830115945925, 4857.0, 4864.124457597666, 4880.92678609814], "unit": "ms", "name": "dojo.html", "value": 4603.279309125056}, {"lowerIsBetter": false, "replicates": [536.9409364969854, 546.2352706211303, 547.0535972767116, 547.089096654071, 547.8575570351708, 26294.211173664797, 26784.598231026503, 26802.865985670094, 26810.4637907242, 26855.731442685566, 27699.446011079766, 35682.0, 36428.271434571296, 36582.26835463289, 36618.63381366186, 7884.05391353037, 7920.089189743167, 7925.3263472604895, 7967.60161991901, 8007.719729809458, 7123.0, 7329.19378868324, 7696.846063078735, 7786.065672119325, 7805.5706936118495, 7086.291370862924, 7167.749128780494, 7168.0, 7173.10336207974, 9876.753081172992, 9912.107910288072, 9954.402735835873, 9999.0, 10012.649557265533, 10014.298999070032, 9838.950805245999, 9969.75075623108, 10004.19966402686, 10004.54979525923, 10017.348872323275, 36525.81737091324, 37016.07459813526, 37026.814865925495, 37052.62947370519, 37066.44400333997, 2653.1112077454077, 2701.122135306033, 3039.8024128431803, 3344.3980083584943, 3360.059183428644, 27270.727292727217, 27498.17505474839, 27960.16119516418, 29876.0, 30345.93228601843, 3200.8239546824916, 3227.5406180312098, 3254.479283314682, 3280.425925463034, 3330.333933213367, 208520.0, 210707.0, 210860.0, 211279.94360028254, 211424.0, 54430.45569544333, 54635.726821365635, 54686.72656636692, 54699.0, 54796.45203547993, 49723.254151187764, 50543.74728126336, 58997.0, 60125.398746012856, 60192.699036504535, 12634.368281585885, 12789.104762666524, 12845.871541284467, 12852.935735321264, 12862.48550058006, 9888.802223955481, 9890.406575605486, 9893.060159284856, 9906.752331191634, 9916.900830991597, 18180.272789088554, 18271.36050238235, 18933.148008339656, 19059.904700476687, 19121.0, 7502.0, 7808.102068262109, 7849.332806711379, 7899.407544434191, 7963.960180199062, 776.2547953964257, 851.7870532366908, 873.3493547307297, 928.7399528132133, 948.4641177734558, 26133.871523701662, 26493.072742453922, 26646.866765666047, 26667.733322666914, 26722.732772672025, 902.4269588811152, 924.6671198368582, 956.9282303827241, 980.9558569864373, 1015.1168483419325, 13748.587542373745, 13863.722725545433, 13902.0, 13910.095843770123, 13934.372953216927, 247227.0, 251583.0, 251597.0, 251758.0, 251929.0, 45020.77489612531, 45493.77253113713, 45526.77236613796, 45551.544484555394, 45578.316325255146, 1040.6773900090996, 1054.3410368519676, 1068.5084860964043, 1130.7851508213414, 1202.3627477436971, 19523.70714439256, 27234.182974510797, 27462.725372746016, 27633.171004869888, 27715.58426623562, 42810.78594607007, 42833.50082747089, 43147.56852431435, 43309.350359744, 43330.0, 225768.0, 229521.0, 234970.0, 236246.0, 236391.0, 28381.716182837907, 28916.27709307284, 28935.421291574472, 29268.70731292745, 29367.11898643044, 32505.674943250266, 32911.50632740559, 33554.32891342208, 33574.66425335715, 33598.83200583982, 30306.0, 31051.844740776152, 37005.629943700216, 38607.0, 38795.61204388033, 32775.18062048468, 32989.0, 33149.66850331466, 33263.667363327026, 33331.166720832174, 32519.349613008082, 33238.833805830815, 33333.16667083342, 33441.66558334483, 33444.83277583597, 27498.032652979524, 29251.561226581194, 29596.520173990782, 29753.702462975958, 29868.70131298659, 23494.29517114489, 24477.0, 26149.60775588406, 26615.656793415306, 26850.865745671148], "unit": "ms", "name": "ext.html", "value": 16576.624345445995}, {"lowerIsBetter": false, "replicates": [273.40397932507125, 274.1460351006615, 276.46641980976716, 280.8890488257137, 281.52281882209655, 14878.553643390702, 15129.167895765728, 15270.23648817559, 15271.694566108672, 15498.767518487231, 15739.685206295868, 15752.84247157528, 15777.0, 15806.0, 15991.920040399811, 4731.739754313511, 4757.976210118944, 4848.2727590861305, 4854.393200849894, 4872.780724867372, 4094.2425651254466, 4858.611311095104, 4860.222364421693, 4870.342503762, 4875.756212189394, 3665.028767376634, 3772.4152756322815, 3773.9433908491396, 5073.3404657394485, 5078.669886457387, 3732.9066773330615, 3760.4923335349786, 3764.6047165047685, 3767.60440153784, 6399.456046236076, 5777.422257774231, 5956.16613674086, 5967.4629283364275, 6393.7762178324, 6393.881070812589, 19489.220431182737, 20585.485362865897, 20735.79264207354, 22376.88811555932, 22395.664065039036, 1620.991895040529, 1636.4272504623286, 1871.3356758350726, 1920.7791104023077, 1944.6499630066583, 12993.0, 13054.477820887154, 13141.86858131416, 13353.265570393625, 13835.30823458833, 1857.0807450312182, 1860.2744929477515, 1916.875403098794, 1925.056722206123, 1962.1856929374292, 60561.6971915142, 64483.0, 64863.02705459469, 65076.0, 65108.348916511175, 15207.31567079484, 15592.142432166112, 15672.373105075669, 15683.843161568238, 15697.764533532007, 23319.883400582887, 23478.413039674146, 23557.0, 23661.29016129519, 23663.526729465313, 8395.832083358298, 8618.655253789904, 8638.395312328203, 8726.781830454163, 8772.912270877338, 7389.778306650809, 7390.371818395389, 7441.851162976818, 7472.402207823361, 7473.626318684044, 7480.17718051014, 7609.923900760921, 7618.0, 7623.199564045806, 7628.160902300742, 2929.4114709480714, 2972.929745291693, 2995.7753168512013, 3015.517517197238, 3017.713317234859, 763.3702195688468, 824.2993455562723, 837.5267973594899, 878.2622597018535, 985.6500942165428, 15585.0, 16003.519894403187, 16033.67932641364, 16286.918565407334, 16465.0, 718.3175982816346, 828.1842385250524, 848.1560846957317, 871.9084496127815, 886.3175354976761, 8470.49177049379, 8785.604647790864, 8819.911800882037, 8896.777580560538, 8949.463032218087, 308490.0, 309347.0, 313150.0, 313775.0, 447118.0, 50732.49267507352, 57859.421405785404, 62937.0, 63436.68281658562, 65624.6718766403, 1005.1757558801712, 1029.7425643589104, 1034.803387356415, 1038.8026275007724, 1040.490159821697, 14524.782128267872, 14574.198419087052, 14611.634709131931, 14666.56000319992, 15124.168170750714, 32157.0, 32896.83551582227, 33281.0, 33634.831825840716, 33798.66201337955, 43513.129737404444, 46450.76774616105, 47977.5202247987, 48030.75984620055, 48298.75850620725, 8071.515709057476, 8082.434229604107, 8350.958245208734, 8359.540225287668, 8389.622466989122, 9292.442453452815, 9403.952980235055, 9446.811063778823, 9584.808303834025, 9606.951965240129, 9814.75463113428, 14083.225422601856, 14143.222122782934, 14152.92923535417, 14177.432902683777, 13018.0, 13836.584902452943, 13897.305134743425, 13986.790198146833, 14036.578902632937, 10633.89366106329, 12238.388080595756, 14199.787003194753, 14385.64035899069, 14506.709865802835, 8066.475679080841, 8692.39153259291, 8865.778355541162, 8866.202041816268, 8876.0, 13297.069205155933, 13555.661108472366, 13765.587032388643, 13801.654958626115, 14110.082844615066], "unit": "ms", "name": "jquery.html", "value": 8675.176300850568}, {"lowerIsBetter": false, "replicates": [1385.854485279045, 1588.4599236259671, 1614.1848366574877, 1640.425850952167, 1653.776740140081, 5907.320658124317, 6665.333466653338, 6832.350926661959, 6839.11091558098, 6849.417799487037, 6827.249002609709, 6934.098567186259, 6944.5486043407145, 6956.478264130185, 6983.685734141963, 1702.4296860551667, 1740.7301868210448, 1970.9211631534722, 2014.4560968538522, 2048.150017742635, 2028.5030167608957, 2028.5334373094197, 2032.8881911494861, 2035.613233485633, 2036.4297996560986, 2000.3398878370176, 2005.6762536725764, 2049.7950204979456, 2050.3438899552148, 2053.6816793397047, 2018.5559176981042, 2029.9289524866633, 2045.98977005114, 2057.3930690446355, 2066.5556905265366, 1955.511122219445, 1976.980230197694, 1978.5943881504256, 1978.673518869385, 1979.1192919150983, 6957.339052789976, 7029.332213439715, 7034.929650703479, 7035.824104397379, 7043.154821421411, 3997.2205419942834, 4040.696947728932, 4059.4316795648633, 4075.7554546726997, 4090.8159132839096, 2458.5082983403213, 2524.7222805491383, 2550.5281522918135, 2554.0294688018434, 2559.1810620601414, 768.7347864986626, 787.5274835098952, 805.267206841777, 806.5523634382915, 817.2930415190876, 8921.286297096216, 8926.86609700855, 8942.776430589221, 8943.463392196489, 8948.821023579492, 3571.964280357215, 3624.5831729350934, 3682.0, 3694.07648087978, 3708.8145592720257, 7794.41541884361, 7803.648835802403, 7808.0, 7819.3744500439825, 7826.0, 4053.9391909121387, 4076.449679293317, 4081.4490043843703, 4085.6935729820384, 4086.6730661547003, 3725.2921944830937, 3726.31063253299, 3730.0, 3731.1418373774186, 3739.607341229186, 2915.3003279213262, 3006.5189569668746, 3025.183200535843, 3046.3602643444683, 3340.615829179627, 1032.1123833503182, 1048.6067724603274, 1054.1672079057612, 1055.3193190392308, 1057.7884423115408, 911.266430523435, 911.4759013567225, 911.5988964855443, 957.2724729205854, 1041.3023274406166, 6618.768343107968, 6707.027481015225, 6710.731570737214, 6715.019069374546, 6720.0, 939.736873675372, 940.8870935487786, 971.5822196455592, 1028.5063169678597, 1033.452270296744, 5198.168293073166, 5235.947640523622, 5252.789888404497, 5261.789528418897, 5262.947370526323, 7778.22217778229, 8066.677332906618, 8116.8782468263025, 8125.634346454423, 8143.75568732939, 8007.679692812222, 8020.79948001293, 8114.959425202955, 8118.553479558681, 8135.064467586303, 6335.271443784024, 6405.878971180025, 6416.647084410309, 6449.548531602836, 6459.709313080923, 6062.939370606237, 6075.969620151871, 6076.088586712029, 6076.210092687922, 6093.29927058394, 7016.859662806817, 7093.609851458219, 7278.199398066103, 7352.154502232098, 7495.063117110361, 6999.265077166824, 7160.820979475555, 7258.346748792634, 7580.431467639839, 7615.1242607098675, 6005.189299444519, 6090.299615544269, 6092.2689277285235, 6102.511799056154, 6112.2970858351855, 6229.53278504123, 6372.203474565679, 6388.936110638834, 6393.584417012879, 6589.769358072444, 6127.264728232641, 6185.659788711484, 6268.874622507433, 6315.336889626707, 6366.64983425916, 6108.419700128481, 6112.572119951561, 6206.410391012847, 6208.689565521616, 6254.437100660781, 6211.192544969125, 6227.906581401373, 6311.968440157953, 6313.116163736989, 6324.209473815773, 5632.408597097246, 5655.095184770417, 5674.375818659862, 5683.175939488834, 5691.26013618227, 5867.911981320369, 5915.911261330997, 5916.763329466773, 5917.526597872074, 5924.407559244213], "unit": "ms", "name": "mootools.html", "value": 3919.644621238558}, {"lowerIsBetter": false, "replicates": [245.14078156063, 249.0089444012829, 249.94751102268512, 251.7796927688273, 253.07375007472655, 5208.296879921209, 5248.029114613794, 5282.075636763566, 5288.127458969266, 5293.15309550472, 5070.923936140961, 5152.0, 5216.478352164781, 5221.817236396727, 5315.202719592063, 3998.120413509038, 4031.516218053823, 4040.3737420699763, 4052.615001574846, 4055.128147448298, 3835.5013848199833, 4049.676025917934, 4053.9797301013455, 4057.1479989202303, 4057.452243947074, 3875.2443273561667, 3898.5126859142606, 3943.152222272211, 3953.6244056814558, 3959.3467077932105, 3942.8817135485983, 3950.348192548226, 3952.960470395288, 3959.5644479107277, 3967.3652215645357, 3445.689887910075, 3446.672566106216, 3450.9827450862836, 3452.4993875887853, 3457.360388328167, 5083.491650834924, 5104.821331253388, 5106.361704786902, 5106.514881086291, 5107.157319042353, 4507.256302710049, 4604.0, 4605.930911036337, 4610.077984403099, 4614.884627884297, 5558.249636299129, 5571.192177134333, 5578.553715702775, 5582.63712858667, 5588.273524441837, 3761.0409345616968, 3765.0775559987705, 3769.1142581493327, 3772.641599048086, 3772.6604605585353, 5922.466977972003, 5931.347551769345, 5931.822045338647, 5932.495737862287, 5937.70311484424, 3765.134019175605, 3859.2474467478573, 3866.6906647468136, 3873.1672690371706, 3889.6110388961442, 3879.2241551689776, 3909.8045097745, 3913.412988051815, 3914.37370020801, 3924.7252692311836, 4522.321651752198, 4528.275475923836, 4577.793999269974, 4578.58064000161, 4578.793954272066, 5611.354694210137, 5623.100303951348, 5624.859378515488, 5625.8593535161945, 5628.774849006076, 1343.8790508854054, 1355.4713661671956, 1381.4336122189854, 1383.370566392289, 1383.889288856889, 879.8078603492304, 895.8790563274005, 904.7828521155008, 906.4833045164193, 906.8981187856785, 4831.782569784368, 4856.781444834991, 4858.319835223072, 4861.611071114302, 4864.246041863516, 5760.049591817387, 5766.192733017381, 5769.249997500298, 5772.220750198753, 5791.391903850119, 4713.787879545429, 4811.230203167476, 4842.95157048425, 4853.514648535189, 4865.391826021747, 3151.7163455289133, 3177.523371494294, 3178.761592880543, 3180.1890517918246, 3188.7085730279273, 5558.0, 5558.138488534203, 5558.471945165203, 5560.860978475571, 5561.054620714488, 6058.303295121029, 6059.757609695651, 6061.575689701678, 6064.3935606439, 6065.2418447694035, 5410.404855465896, 5576.386597474275, 5585.441455854463, 5589.0, 5589.077802162597, 5902.527797776082, 5914.260717410324, 5915.349311575637, 5920.082387229986, 5923.763049477972, 5799.82600521985, 5801.274840644919, 5806.896689628957, 5806.970965145148, 5813.04084825999, 5415.079436495726, 5563.610547261653, 5575.470330318613, 5587.8882422352135, 5595.07681232592, 3771.73597848148, 3809.257194846978, 3812.9618703813717, 3813.9702280384695, 3815.2369526094335, 5909.70451477433, 5914.822555323347, 5916.201312822714, 5922.082077278029, 5923.141144533933, 5679.290088738908, 5691.174779657009, 5692.51613612831, 5695.0, 5699.658020518782, 5537.086380747131, 5682.857928551819, 5691.146328050825, 5695.544356451391, 5701.914471282851, 5572.136318870419, 5572.3034620672415, 5574.665520068809, 5576.470235327637, 5576.581756368208, 5732.05421105513, 5735.971320143372, 5736.741846616829, 5738.971305143447, 5743.10981797822, 5440.564754819526, 5587.860303492283, 5591.021571224938, 5591.10542313228, 5593.664380137205], "unit": "ms", "name": "prototype.html", "value": 4139.534702757185}, {"lowerIsBetter": false, "replicates": [793.853137169624, 797.5493845977023, 799.4124318625809, 801.9759407217786, 807.6728924785463, 10568.682939511817, 11034.613788517403, 11081.722956926082, 11084.833727494093, 11108.722281942955, 11791.941040294809, 11872.347020913869, 11887.049036077115, 11893.0, 11921.165518413714, 612.3570251236206, 620.0358442621722, 621.0590954703628, 769.3306823063929, 787.1695361393728, 616.3066550131102, 623.2489849731086, 779.4543819326466, 790.8734602463607, 799.188823344306, 823.8928939237891, 823.9176082391773, 828.0766944856472, 830.2030051150903, 831.3723139030054, 633.3887798274641, 817.5094943034192, 817.7138001699417, 818.6561644109458, 818.8567000774871, 474.964377671676, 604.8397174748695, 614.6742226619854, 615.6521565315583, 615.9106929495198, 11528.365939873387, 11738.471768770425, 11774.587889423829, 11789.528418863236, 11822.054235661126, 10724.892751072468, 11256.155788315828, 11281.097512199087, 11400.372979486125, 12104.455299511543, 9160.954195228982, 9361.953190234006, 9497.240220782322, 9536.52317384135, 9687.079727425884, 3247.334296469242, 3272.6563710810497, 3310.6027276726704, 3313.6520665330036, 3323.401787678217, 37786.43320350197, 37877.0, 37982.0, 38020.23959520794, 38070.42894356587, 8913.643454261886, 9391.765205869771, 9449.385789923634, 9477.336586439022, 9523.666671666459, 16025.919870400574, 16128.112953787655, 16151.757723634155, 16161.757573636405, 16166.919165404333, 6076.149339092531, 6103.115048317969, 6220.533459990519, 6232.781852635136, 6234.750609975641, 3435.089701229176, 3449.3963556377535, 3453.4129198035894, 3459.056874303037, 3599.8200089995394, 2611.099170786076, 2634.76287134155, 2645.008121954267, 2646.5897785843226, 2652.7745141663177, 450.0526391944909, 450.9616385269965, 457.44420529057356, 458.80500787165323, 462.02973755114664, 508.7990243853657, 529.1929807044212, 555.0453220460801, 578.887117012187, 598.5839841310247, 7383.778486645409, 7493.85012299751, 7591.810204744926, 7707.152213256537, 7727.188645192174, 467.847949416441, 503.5166240409248, 519.929809475716, 595.2826843653387, 613.1018058544254, 3713.9071523211596, 3714.665680088751, 3731.1231860512758, 3760.4923335349927, 3773.6792372648633, 48443.51556484461, 48816.26775598369, 48956.02087958221, 49064.26403603949, 49109.75445122751, 38544.80727596344, 39258.0, 48871.511284887405, 49041.264381034314, 49092.75453622709, 39441.0, 40554.1889162221, 40589.79705101455, 40733.59266407298, 41001.17997640031, 8027.638756255866, 8062.193780621891, 8082.313003394777, 8088.150744171778, 8383.245507904317, 29303.85348073246, 29511.704882950897, 29715.851420742758, 30078.699213008465, 32333.0, 38292.80853595714, 38748.0, 38815.417768734056, 39365.21269574535, 39384.0, 9793.118619324296, 9875.65435209793, 9918.534519313904, 9932.950335248277, 10244.795104098026, 11169.273997190157, 11292.661220163409, 11304.265222760494, 11349.659510214708, 11388.430578470878, 10286.331388459726, 10477.895221047693, 10554.10290125348, 10588.523516441624, 10973.83539246896, 10505.107065899485, 10619.36283822973, 10675.57297708083, 10784.299020563638, 11063.0, 10452.32059916103, 10465.319754215952, 10595.682129536126, 10623.150147988297, 10763.300385474919, 9214.493202873906, 9347.579358928728, 9458.43249405038, 9570.377925434825, 9619.989901060288, 8815.559222039, 8998.775030624287, 9072.092790720875, 9079.273658107204, 9087.136722011399], "unit": "ms", "name": "yui.html", "value": 5622.640097221809}], "name": "dromaeo_css", "value": 6263.801164083287}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 106.0, 113.0, 113.0, 113.0, 101.0, 115.0, 111.0, 106.0], "unit": "ms", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [156.0, 130.0, 154.0, 175.0, 129.0, 152.0, 161.0, 134.0, 171.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 162.0, 160.0, 161.0, 160.0, 161.0, 163.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 87.0, 94.0, 74.0, 73.0, 72.0, 108.0, 87.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 130.0, 94.0, 95.0, 95.0, 136.0, 93.0, 95.0, 129.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 73.0, 72.0, 72.0, 72.0, 72.0, 71.0, 71.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 71.5}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 86.0, 85.0, 92.0, 84.0, 85.0, 85.0, 84.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [120.0, 125.0, 125.0, 123.0, 124.0, 120.0, 118.0, 122.0, 129.0, 130.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [136.0, 138.0, 147.0, 146.0, 152.0, 135.0, 150.0, 147.0, 146.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 70.0, 68.0, 70.0, 68.0, 69.0, 72.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1520.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [186.28912071535024], "unit": "score", "name": "DeltaBlue", "value": 354.92142400000006}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [27432.432432432433], "unit": "score", "name": "RegExp", "value": 33.208320197044344}, {"lowerIsBetter": false, "replicates": [741.2898443291327], "unit": "score", "name": "Splay", "value": 109.931359}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19370.47046276968}]} 03:25:35 INFO - RETURN: dromaeo_css: 6263.80 03:25:35 INFO - RETURN: kraken: 1520.20 03:25:35 INFO - RETURN: v8_7: 19370.47 03:25:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19370.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1520.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6263.80"}}} 03:25:35 INFO - Return code: 0 03:25:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:25:35 ERROR - # TBPL SUCCESS # 03:25:35 INFO - Running post-action listener: _resource_record_post_action 03:25:35 INFO - Running post-run listener: _resource_record_post_run 03:25:36 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 3399680; Write bytes: 347095040; Read time: 316; Write time: 275100 03:25:36 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 71958528; Read time: 0; Write time: 71468 03:25:36 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 3399680; Write bytes: 275136512; Read time: 316; Write time: 203632 03:25:36 INFO - Running post-run listener: _upload_blobber_files 03:25:36 INFO - Blob upload gear active. 03:25:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:25:36 INFO - Copying logs to upload dir... 03:25:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.223387 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-09 03:25:36.182720) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:25:36.185991) ========= 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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009399 build_url: 'https://queue.taskcluster.net/v1/task/AWHRhVPTQ02uJ2Q0S5gXqQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 03:25:36.238013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:25:36.238493) ========= 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=004b26eee9c3b360c8654f40000001e1-1449656244.970445-1454332203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004518 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 03:25:36.288422) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 03:25:36.288756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 03:25:36.289064) ========= ========= Total master_lag: 0.15 =========