builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1449134860.77 results: success (0) buildid: 20151203005925 builduid: 9e23c050f9004bf79f445e6bf9cb82bb revision: 92499b34eeffbfdaf5df19f63c464988435356db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.771596) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.772074) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.772369) ========= 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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006216 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.794829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.795149) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.809706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.810071) ========= 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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004549 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.859177) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.859586) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.860005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:40.860285) ========= 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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 01:27:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2015-12-03 01:27:41 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178385 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.050911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.051236) ========= 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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014670 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.101377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.101747) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 92499b34eeffbfdaf5df19f63c464988435356db --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 92499b34eeffbfdaf5df19f63c464988435356db --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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 01:27:41,586 truncating revision to first 12 chars 2015-12-03 01:27:41,586 Setting DEBUG logging. 2015-12-03 01:27:41,586 attempt 1/10 2015-12-03 01:27:41,586 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/92499b34eeff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 01:27:41,845 unpacking tar archive at: fx-team-92499b34eeff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550632 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.665504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.665803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.675685) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.676005) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 01:27:41.676405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-03 01:27:41.676692) ========= /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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:27:42 INFO - MultiFileLogger online at 20151203 01:27:42 in /builds/slave/test 01:27:42 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 01:27:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:27:42 INFO - {'append_to_log': False, 01:27:42 INFO - 'base_work_dir': '/builds/slave/test', 01:27:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:27:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:27:42 INFO - 'branch': 'Fx-Team-Non-PGO', 01:27:42 INFO - 'buildbot_json_path': 'buildprops.json', 01:27:42 INFO - 'config_files': ('talos/linux_config.py',), 01:27:42 INFO - 'default_actions': ('clobber', 01:27:42 INFO - 'read-buildbot-config', 01:27:42 INFO - 'download-and-extract', 01:27:42 INFO - 'populate-webroot', 01:27:42 INFO - 'create-virtualenv', 01:27:42 INFO - 'install', 01:27:42 INFO - 'run-tests'), 01:27:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:27:42 INFO - 'download_minidump_stackwalk': True, 01:27:42 INFO - 'download_symbols': 'ondemand', 01:27:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:27:42 INFO - 'tooltool.py': '/tools/tooltool.py', 01:27:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:27:42 INFO - '/tools/misc-python/virtualenv.py')}, 01:27:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:27:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:27:42 INFO - 'installer_path': 'installer.exe', 01:27:42 INFO - 'log_level': 'info', 01:27:42 INFO - 'log_name': 'talos', 01:27:42 INFO - 'log_to_console': True, 01:27:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:27:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:27:42 INFO - 'opt_config_files': (), 01:27:42 INFO - 'pip_index': False, 01:27:42 INFO - 'sps_profile': False, 01:27:42 INFO - 'sps_profile_interval': 0, 01:27:42 INFO - 'suite': 'dromaeojs', 01:27:42 INFO - 'system_bits': '64', 01:27:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:27:42 INFO - 'title': 'talos-linux64-ix-042', 01:27:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:27:42 INFO - 'use_talos_json': True, 01:27:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:27:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:27:42 INFO - 'work_dir': 'build'} 01:27:42 INFO - ##### 01:27:42 INFO - ##### Running clobber step. 01:27:42 INFO - ##### 01:27:42 INFO - Running pre-action listener: _resource_record_pre_action 01:27:42 INFO - Running main action method: clobber 01:27:42 INFO - rmtree: /builds/slave/test/build 01:27:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:27:42 INFO - Running post-action listener: _resource_record_post_action 01:27:42 INFO - ##### 01:27:42 INFO - ##### Running read-buildbot-config step. 01:27:42 INFO - ##### 01:27:42 INFO - Running pre-action listener: _resource_record_pre_action 01:27:42 INFO - Running main action method: read_buildbot_config 01:27:42 INFO - Using buildbot properties: 01:27:42 INFO - { 01:27:42 INFO - "properties": { 01:27:42 INFO - "buildnumber": 2171, 01:27:42 INFO - "product": "firefox", 01:27:42 INFO - "script_repo_revision": "production", 01:27:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:27:42 INFO - "repository": "", 01:27:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:27:42 INFO - "buildid": "20151203005925", 01:27:42 INFO - "slavename": "talos-linux64-ix-042", 01:27:42 INFO - "pgo_build": "False", 01:27:42 INFO - "basedir": "/builds/slave/test", 01:27:42 INFO - "project": "", 01:27:42 INFO - "platform": "ubuntu64_hw", 01:27:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:27:42 INFO - "slavebuilddir": "test", 01:27:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:27:42 INFO - "branch": "fx-team", 01:27:42 INFO - "repo_path": "integration/fx-team", 01:27:42 INFO - "stage_platform": "linux64", 01:27:42 INFO - "builduid": "9e23c050f9004bf79f445e6bf9cb82bb", 01:27:42 INFO - "revision": "92499b34eeffbfdaf5df19f63c464988435356db" 01:27:42 INFO - }, 01:27:42 INFO - "sourcestamp": { 01:27:42 INFO - "repository": "", 01:27:42 INFO - "hasPatch": false, 01:27:42 INFO - "project": "", 01:27:42 INFO - "branch": "fx-team-linux64-talos", 01:27:42 INFO - "changes": [ 01:27:42 INFO - { 01:27:42 INFO - "category": null, 01:27:42 INFO - "files": [ 01:27:42 INFO - { 01:27:42 INFO - "url": null, 01:27:42 INFO - "name": "https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 01:27:42 INFO - } 01:27:42 INFO - ], 01:27:42 INFO - "repository": "", 01:27:42 INFO - "rev": "92499b34eeffbfdaf5df19f63c464988435356db", 01:27:42 INFO - "who": "pbrosset@mozilla.com", 01:27:42 INFO - "when": 1449134738, 01:27:42 INFO - "number": 6738181, 01:27:42 INFO - "comments": "Bug 1225514 - Simple fix for searching with attribute selectors in the inspector; r=bgrins", 01:27:42 INFO - "project": "", 01:27:42 INFO - "at": "Thu 03 Dec 2015 01:25:38", 01:27:42 INFO - "branch": "fx-team-linux64-talos", 01:27:42 INFO - "revlink": "", 01:27:42 INFO - "properties": [ 01:27:42 INFO - [ 01:27:42 INFO - "buildid", 01:27:42 INFO - "20151203005925", 01:27:42 INFO - "Change" 01:27:42 INFO - ], 01:27:42 INFO - [ 01:27:42 INFO - "builduid", 01:27:42 INFO - "9e23c050f9004bf79f445e6bf9cb82bb", 01:27:42 INFO - "Change" 01:27:42 INFO - ], 01:27:42 INFO - [ 01:27:42 INFO - "pgo_build", 01:27:42 INFO - "False", 01:27:42 INFO - "Change" 01:27:42 INFO - ] 01:27:42 INFO - ], 01:27:42 INFO - "revision": "92499b34eeffbfdaf5df19f63c464988435356db" 01:27:42 INFO - } 01:27:42 INFO - ], 01:27:42 INFO - "revision": "92499b34eeffbfdaf5df19f63c464988435356db" 01:27:42 INFO - } 01:27:42 INFO - } 01:27:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 01:27:42 INFO - Running post-action listener: _resource_record_post_action 01:27:42 INFO - ##### 01:27:42 INFO - ##### Running download-and-extract step. 01:27:42 INFO - ##### 01:27:42 INFO - Running pre-action listener: _resource_record_pre_action 01:27:42 INFO - Running main action method: download_and_extract 01:27:42 INFO - mkdir: /builds/slave/test/build/tests 01:27:42 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')]} 01:27:42 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:27:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json 01:27:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json 01:27:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:27:43 INFO - Downloaded 1302 bytes. 01:27:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:27:43 INFO - Using the following test package requirements: 01:27:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:27:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'jsshell-linux-x86_64.zip'], 01:27:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:27:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:27:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:27:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:27:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 01:27:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 01:27:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:27:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:27: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')]} 01:27:43 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:27:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:44 INFO - Downloaded 21774562 bytes. 01:27:44 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 01:27:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:44 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 01:27:45 INFO - Return code: 0 01:27:45 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 01:27:45 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')]} 01:27:45 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:48 INFO - Downloaded 21774562 bytes. 01:27:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 01:27:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 01:27:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 01:27:49 INFO - Return code: 0 01:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:49 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:27:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:50 INFO - Downloaded 11132001 bytes. 01:27:50 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 01:27:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 01:27:50 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 01:27:50 INFO - Return code: 0 01:27: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')]} 01:27:50 INFO - https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:27:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LyCNorK9SBueuTbFU1lNyA/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 01:27:51 INFO - Downloaded 57683488 bytes. 01:27:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:51 INFO - mkdir: /builds/slave/test/properties 01:27:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:27:51 INFO - Writing to file /builds/slave/test/properties/build_url 01:27:51 INFO - Contents: 01:27:51 INFO - build_url:https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 01:27:51 INFO - Running post-action listener: _resource_record_post_action 01:27:51 INFO - Running post-action listener: set_extra_try_arguments 01:27:51 INFO - ##### 01:27:51 INFO - ##### Running populate-webroot step. 01:27:51 INFO - ##### 01:27:51 INFO - Running pre-action listener: _resource_record_pre_action 01:27:51 INFO - Running main action method: populate_webroot 01:27:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:27:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:27:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 01:27:52 INFO - '../fennec_ids.txt'], 01:27:52 INFO - 'tests': ['tcheck2']}, 01:27:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:27:52 INFO - '--tppagecycles', 01:27:52 INFO - '7'], 01:27:52 INFO - 'tests': ['tsvgm']}}, 01:27:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:27:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:27:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:27:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:27:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:27:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'tests': ['damp', 'tps']}, 01:27:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['damp', 'tps']}, 01:27:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:27:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:27:52 INFO - 'other': {'tests': ['a11yr', 01:27:52 INFO - 'ts_paint', 01:27:52 INFO - 'tpaint', 01:27:52 INFO - 'sessionrestore', 01:27:52 INFO - 'sessionrestore_no_auto_restore']}, 01:27:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['a11yr', 01:27:52 INFO - 'ts_paint', 01:27:52 INFO - 'tpaint', 01:27:52 INFO - 'sessionrestore', 01:27:52 INFO - 'sessionrestore_no_auto_restore']}, 01:27:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['a11yr', 01:27:52 INFO - 'ts_paint', 01:27:52 INFO - 'tpaint', 01:27:52 INFO - 'sessionrestore', 01:27:52 INFO - 'sessionrestore_no_auto_restore']}, 01:27:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['a11yr', 01:27:52 INFO - 'ts_paint', 01:27:52 INFO - 'tpaint', 01:27:52 INFO - 'sessionrestore', 01:27:52 INFO - 'sessionrestore_no_auto_restore']}, 01:27:52 INFO - 'other_l64': {'tests': ['a11yr', 01:27:52 INFO - 'ts_paint', 01:27:52 INFO - 'tpaint', 01:27:52 INFO - 'sessionrestore', 01:27:52 INFO - 'sessionrestore_no_auto_restore']}, 01:27:52 INFO - 'other_nol64': {'tests': ['a11yr', 01:27:52 INFO - 'ts_paint', 01:27:52 INFO - 'tpaint', 01:27:52 INFO - 'sessionrestore', 01:27:52 INFO - 'sessionrestore_no_auto_restore']}, 01:27:52 INFO - 'svgr': {'tests': ['tsvgx', 01:27:52 INFO - 'tsvgr_opacity', 01:27:52 INFO - 'tart', 01:27:52 INFO - 'tscrollx', 01:27:52 INFO - 'cart']}, 01:27:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['tsvgx', 01:27:52 INFO - 'tsvgr_opacity', 01:27:52 INFO - 'tart', 01:27:52 INFO - 'tscrollx', 01:27:52 INFO - 'cart']}, 01:27:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'tests': ['tp5o']}, 01:27:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'talos_options': ['--e10s'], 01:27:52 INFO - 'tests': ['tp5o']}, 01:27:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'talos_options': ['--xperf_path', 01:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:52 INFO - 'tests': ['tp5n']}, 01:27:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:27:52 INFO - 'talos_options': ['--e10s', 01:27:52 INFO - '--xperf_path', 01:27:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:27:52 INFO - 'tests': ['tp5n']}}, 01:27:52 INFO - 'talos.zip': {'path': '', 01:27:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:27:52 INFO - Running post-action listener: _resource_record_post_action 01:27:52 INFO - ##### 01:27:52 INFO - ##### Running create-virtualenv step. 01:27:52 INFO - ##### 01:27:52 INFO - Running pre-action listener: _resource_record_pre_action 01:27:52 INFO - Running main action method: create_virtualenv 01:27:52 INFO - Creating virtualenv /builds/slave/test/build/venv 01:27:52 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 01:27:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:27:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:27:52 INFO - Using real prefix '/usr' 01:27:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:27:52 INFO - Installing distribute.............................................................................................................................................................................................done. 01:27:54 INFO - Installing pip.................done. 01:27:54 INFO - Return code: 0 01:27:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:27: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', 'pip>=1.5'] in /builds/slave/test/build 01:27: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 pip>=1.5 01:27:54 INFO - Using env: {'DISPLAY': ':0', 01:27:54 INFO - 'HOME': '/home/cltbld', 01:27:54 INFO - 'LANG': 'en_US.UTF-8', 01:27:54 INFO - 'LANGUAGE': 'en_US:en', 01:27:54 INFO - 'LOGNAME': 'cltbld', 01:27:54 INFO - 'MAIL': '/var/mail/cltbld', 01:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:54 INFO - 'MOZ_NO_REMOTE': '1', 01:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:54 INFO - 'NO_EM_RESTART': '1', 01:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:54 INFO - 'PWD': '/builds/slave/test', 01:27:54 INFO - 'SHELL': '/bin/bash', 01:27:54 INFO - 'SHLVL': '1', 01:27:54 INFO - 'TERM': 'linux', 01:27:54 INFO - 'TMOUT': '86400', 01:27:54 INFO - 'USER': 'cltbld', 01:27:54 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:54 INFO - '_': '/tools/buildbot/bin/python'} 01:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:54 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 01:27:54 INFO - Cleaning up... 01:27:54 INFO - Return code: 0 01:27:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:27: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')]} 01:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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')]} 01:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27: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', '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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:27: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', 'psutil>=0.7.1'] in /builds/slave/test/build 01:27: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 psutil>=0.7.1 01:27:54 INFO - Using env: {'DISPLAY': ':0', 01:27:54 INFO - 'HOME': '/home/cltbld', 01:27:54 INFO - 'LANG': 'en_US.UTF-8', 01:27:54 INFO - 'LANGUAGE': 'en_US:en', 01:27:54 INFO - 'LOGNAME': 'cltbld', 01:27:54 INFO - 'MAIL': '/var/mail/cltbld', 01:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:54 INFO - 'MOZ_NO_REMOTE': '1', 01:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:54 INFO - 'NO_EM_RESTART': '1', 01:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:54 INFO - 'PWD': '/builds/slave/test', 01:27:54 INFO - 'SHELL': '/bin/bash', 01:27:54 INFO - 'SHLVL': '1', 01:27:54 INFO - 'TERM': 'linux', 01:27:54 INFO - 'TMOUT': '86400', 01:27:54 INFO - 'USER': 'cltbld', 01:27:54 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:54 INFO - '_': '/tools/buildbot/bin/python'} 01:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:55 INFO - Downloading/unpacking psutil>=0.7.1 01:27:55 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 01:27:55 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 01:27:55 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 01:27:55 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 01:27:55 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 01:27:55 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 01:27:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:27:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:27:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:56 INFO - Installing collected packages: psutil 01:27:56 INFO - Running setup.py install for psutil 01:27:56 INFO - building 'psutil._psutil_linux' extension 01:27:56 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 01:27:57 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 01:27:57 INFO - building 'psutil._psutil_posix' extension 01:27:57 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 01:27:57 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 01:27:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:27:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:27:57 INFO - Successfully installed psutil 01:27:57 INFO - Cleaning up... 01:27:57 INFO - Return code: 0 01:27:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:27:57 INFO - Using env: {'DISPLAY': ':0', 01:27:57 INFO - 'HOME': '/home/cltbld', 01:27:57 INFO - 'LANG': 'en_US.UTF-8', 01:27:57 INFO - 'LANGUAGE': 'en_US:en', 01:27:57 INFO - 'LOGNAME': 'cltbld', 01:27:57 INFO - 'MAIL': '/var/mail/cltbld', 01:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:57 INFO - 'MOZ_NO_REMOTE': '1', 01:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:57 INFO - 'NO_EM_RESTART': '1', 01:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:57 INFO - 'PWD': '/builds/slave/test', 01:27:57 INFO - 'SHELL': '/bin/bash', 01:27:57 INFO - 'SHLVL': '1', 01:27:57 INFO - 'TERM': 'linux', 01:27:57 INFO - 'TMOUT': '86400', 01:27:57 INFO - 'USER': 'cltbld', 01:27:57 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:57 INFO - '_': '/tools/buildbot/bin/python'} 01:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:27:57 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 01:27:57 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 01:27:57 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 01:27:57 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 01:27:57 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 01:27:57 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 01:27:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:27:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:27:59 INFO - Installing collected packages: mozsystemmonitor 01:27:59 INFO - Running setup.py install for mozsystemmonitor 01:27:59 INFO - Successfully installed mozsystemmonitor 01:27:59 INFO - Cleaning up... 01:27:59 INFO - Return code: 0 01:27:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:27:59 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')]} 01:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:59 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')]} 01:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:27:59 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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:27:59 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 01:27:59 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 01:27:59 INFO - Using env: {'DISPLAY': ':0', 01:27:59 INFO - 'HOME': '/home/cltbld', 01:27:59 INFO - 'LANG': 'en_US.UTF-8', 01:27:59 INFO - 'LANGUAGE': 'en_US:en', 01:27:59 INFO - 'LOGNAME': 'cltbld', 01:27:59 INFO - 'MAIL': '/var/mail/cltbld', 01:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:27:59 INFO - 'MOZ_NO_REMOTE': '1', 01:27:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:27:59 INFO - 'NO_EM_RESTART': '1', 01:27:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:27:59 INFO - 'PWD': '/builds/slave/test', 01:27:59 INFO - 'SHELL': '/bin/bash', 01:27:59 INFO - 'SHLVL': '1', 01:27:59 INFO - 'TERM': 'linux', 01:27:59 INFO - 'TMOUT': '86400', 01:27:59 INFO - 'USER': 'cltbld', 01:27:59 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:27:59 INFO - '_': '/tools/buildbot/bin/python'} 01:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:27:59 INFO - Downloading/unpacking blobuploader==1.2.4 01:27:59 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 01:27:59 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 01:27:59 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 01:27:59 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 01:27:59 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 01:27:59 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 01:28:01 INFO - Downloading blobuploader-1.2.4.tar.gz 01:28:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:28:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:28:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 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 01:28:01 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 01:28:02 INFO - Downloading docopt-0.6.1.tar.gz 01:28:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:28:02 INFO - Installing collected packages: blobuploader, requests, docopt 01:28:02 INFO - Running setup.py install for blobuploader 01:28:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:28:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:28:02 INFO - Running setup.py install for requests 01:28:02 INFO - Running setup.py install for docopt 01:28:02 INFO - Successfully installed blobuploader requests docopt 01:28:02 INFO - Cleaning up... 01:28:02 INFO - Return code: 0 01:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:02 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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:28:02 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 01:28:02 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 01:28:02 INFO - Using env: {'DISPLAY': ':0', 01:28:02 INFO - 'HOME': '/home/cltbld', 01:28:02 INFO - 'LANG': 'en_US.UTF-8', 01:28:02 INFO - 'LANGUAGE': 'en_US:en', 01:28:02 INFO - 'LOGNAME': 'cltbld', 01:28:02 INFO - 'MAIL': '/var/mail/cltbld', 01:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:02 INFO - 'MOZ_NO_REMOTE': '1', 01:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:02 INFO - 'NO_EM_RESTART': '1', 01:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:02 INFO - 'PWD': '/builds/slave/test', 01:28:02 INFO - 'SHELL': '/bin/bash', 01:28:02 INFO - 'SHLVL': '1', 01:28:02 INFO - 'TERM': 'linux', 01:28:02 INFO - 'TMOUT': '86400', 01:28:02 INFO - 'USER': 'cltbld', 01:28:02 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:02 INFO - '_': '/tools/buildbot/bin/python'} 01:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:02 INFO - Running setup.py (path:/tmp/pip-3slD3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:03 INFO - Running setup.py (path:/tmp/pip-jilt_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:03 INFO - Running setup.py (path:/tmp/pip-eY0_v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:03 INFO - Running setup.py (path:/tmp/pip-c5YSgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:03 INFO - Running setup.py (path:/tmp/pip-q_IPbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:03 INFO - Running setup.py (path:/tmp/pip-DvgZIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:03 INFO - Running setup.py (path:/tmp/pip-2Ps6Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:03 INFO - Running setup.py (path:/tmp/pip-bVBrx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:03 INFO - Running setup.py (path:/tmp/pip-djxcYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:03 INFO - Running setup.py (path:/tmp/pip-NbGpnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:03 INFO - Running setup.py (path:/tmp/pip-3DppuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:03 INFO - Running setup.py (path:/tmp/pip-zbX9Ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:03 INFO - Running setup.py (path:/tmp/pip-ew3U76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:03 INFO - Running setup.py (path:/tmp/pip-FFGYh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:03 INFO - Running setup.py (path:/tmp/pip-m54zSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:04 INFO - Running setup.py (path:/tmp/pip-huImr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:04 INFO - Running setup.py (path:/tmp/pip-04odQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:28:04 INFO - Running setup.py install for manifestparser 01:28:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozcrash 01:28:04 INFO - Running setup.py install for mozdebug 01:28:04 INFO - Running setup.py install for mozdevice 01:28:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozfile 01:28:04 INFO - Running setup.py install for mozhttpd 01:28:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozinfo 01:28:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozInstall 01:28:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:28:04 INFO - Running setup.py install for mozleak 01:28:05 INFO - Running setup.py install for mozlog 01:28:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Running setup.py install for moznetwork 01:28:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Running setup.py install for mozprocess 01:28:05 INFO - Running setup.py install for mozprofile 01:28:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Running setup.py install for mozrunner 01:28:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Running setup.py install for mozscreenshot 01:28:05 INFO - Running setup.py install for moztest 01:28:05 INFO - Running setup.py install for mozversion 01:28:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:28:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:28:05 INFO - Cleaning up... 01:28:05 INFO - Return code: 0 01:28:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:28:05 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 01:28:05 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 01:28:05 INFO - Using env: {'DISPLAY': ':0', 01:28:05 INFO - 'HOME': '/home/cltbld', 01:28:05 INFO - 'LANG': 'en_US.UTF-8', 01:28:05 INFO - 'LANGUAGE': 'en_US:en', 01:28:05 INFO - 'LOGNAME': 'cltbld', 01:28:05 INFO - 'MAIL': '/var/mail/cltbld', 01:28:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:05 INFO - 'MOZ_NO_REMOTE': '1', 01:28:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:05 INFO - 'NO_EM_RESTART': '1', 01:28:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:05 INFO - 'PWD': '/builds/slave/test', 01:28:05 INFO - 'SHELL': '/bin/bash', 01:28:05 INFO - 'SHLVL': '1', 01:28:05 INFO - 'TERM': 'linux', 01:28:05 INFO - 'TMOUT': '86400', 01:28:05 INFO - 'USER': 'cltbld', 01:28:05 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:28:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:05 INFO - '_': '/tools/buildbot/bin/python'} 01:28:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:28:06 INFO - Running setup.py (path:/tmp/pip-3ZmzOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:28:06 INFO - Running setup.py (path:/tmp/pip-DFnh_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:28:06 INFO - Running setup.py (path:/tmp/pip-1uKEyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:28:06 INFO - Running setup.py (path:/tmp/pip-OBn4Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:28:06 INFO - Running setup.py (path:/tmp/pip-4zjIup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:28:06 INFO - Running setup.py (path:/tmp/pip-xdOHgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:28:06 INFO - Running setup.py (path:/tmp/pip-jU3z6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:28:06 INFO - Running setup.py (path:/tmp/pip-h1eXep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:28:06 INFO - Running setup.py (path:/tmp/pip-_GzqV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:28:06 INFO - Running setup.py (path:/tmp/pip-Z7qgFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:28:06 INFO - Running setup.py (path:/tmp/pip-pjJFm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:28:06 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)) 01:28:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:28:06 INFO - Running setup.py (path:/tmp/pip-zrYRUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:28:07 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)) 01:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:28:07 INFO - Running setup.py (path:/tmp/pip-mMXhUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:28:07 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)) 01:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:28:07 INFO - Running setup.py (path:/tmp/pip-ScdAQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:28:07 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)) 01:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:07 INFO - Running setup.py (path:/tmp/pip-fAmKIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:28:07 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)) 01:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:28:07 INFO - Running setup.py (path:/tmp/pip-hKftzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:28:07 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)) 01:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:28:07 INFO - Running setup.py (path:/tmp/pip-lgpviJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 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)) 01:28:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:28:07 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 01:28:07 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 01:28:07 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 01:28:07 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 01:28:07 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 01:28:07 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 01:28:09 INFO - Downloading blessings-1.5.1.tar.gz 01:28:09 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 01:28:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:28:09 INFO - Installing collected packages: blessings 01:28:09 INFO - Running setup.py install for blessings 01:28:09 INFO - Successfully installed blessings 01:28:09 INFO - Cleaning up... 01:28:09 INFO - Return code: 0 01:28:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:28:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:09 INFO - Reading from file tmpfile_stdout 01:28:09 INFO - Current package versions: 01:28:09 INFO - argparse == 1.2.1 01:28:09 INFO - blessings == 1.5.1 01:28:09 INFO - blobuploader == 1.2.4 01:28:09 INFO - docopt == 0.6.1 01:28:09 INFO - manifestparser == 1.1 01:28:09 INFO - mozInstall == 1.12 01:28:09 INFO - mozcrash == 0.16 01:28:09 INFO - mozdebug == 0.1 01:28:09 INFO - mozdevice == 0.47 01:28:09 INFO - mozfile == 1.2 01:28:09 INFO - mozhttpd == 0.7 01:28:09 INFO - mozinfo == 0.9 01:28:09 INFO - mozleak == 0.1 01:28:09 INFO - mozlog == 3.1 01:28:09 INFO - moznetwork == 0.27 01:28:09 INFO - mozprocess == 0.22 01:28:09 INFO - mozprofile == 0.27 01:28:09 INFO - mozrunner == 6.11 01:28:09 INFO - mozscreenshot == 0.1 01:28:09 INFO - mozsystemmonitor == 0.0 01:28:09 INFO - moztest == 0.7 01:28:09 INFO - mozversion == 1.4 01:28:09 INFO - psutil == 3.1.1 01:28:09 INFO - requests == 1.2.3 01:28:09 INFO - wsgiref == 0.1.2 01:28:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 01:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 01:28:09 INFO - Using env: {'DISPLAY': ':0', 01:28:09 INFO - 'HOME': '/home/cltbld', 01:28:09 INFO - 'LANG': 'en_US.UTF-8', 01:28:09 INFO - 'LANGUAGE': 'en_US:en', 01:28:09 INFO - 'LOGNAME': 'cltbld', 01:28:09 INFO - 'MAIL': '/var/mail/cltbld', 01:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:09 INFO - 'MOZ_NO_REMOTE': '1', 01:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:09 INFO - 'NO_EM_RESTART': '1', 01:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:09 INFO - 'PWD': '/builds/slave/test', 01:28:09 INFO - 'SHELL': '/bin/bash', 01:28:09 INFO - 'SHLVL': '1', 01:28:09 INFO - 'TERM': 'linux', 01:28:09 INFO - 'TMOUT': '86400', 01:28:09 INFO - 'USER': 'cltbld', 01:28:09 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:09 INFO - '_': '/tools/buildbot/bin/python'} 01:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 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)) 01:28:09 INFO - Cleaning up... 01:28:09 INFO - Return code: 0 01:28:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:28:09 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 01:28:09 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 01:28:09 INFO - Using env: {'DISPLAY': ':0', 01:28:09 INFO - 'HOME': '/home/cltbld', 01:28:09 INFO - 'LANG': 'en_US.UTF-8', 01:28:09 INFO - 'LANGUAGE': 'en_US:en', 01:28:09 INFO - 'LOGNAME': 'cltbld', 01:28:09 INFO - 'MAIL': '/var/mail/cltbld', 01:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:09 INFO - 'MOZ_NO_REMOTE': '1', 01:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:09 INFO - 'NO_EM_RESTART': '1', 01:28:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:09 INFO - 'PWD': '/builds/slave/test', 01:28:09 INFO - 'SHELL': '/bin/bash', 01:28:09 INFO - 'SHLVL': '1', 01:28:09 INFO - 'TERM': 'linux', 01:28:09 INFO - 'TMOUT': '86400', 01:28:09 INFO - 'USER': 'cltbld', 01:28:09 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:09 INFO - '_': '/tools/buildbot/bin/python'} 01:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:10 INFO - Downloading/unpacking jsonschema 01:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:28:11 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 01:28:11 INFO - Downloading/unpacking functools32 (from jsonschema) 01:28:11 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 01:28:11 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 01:28:11 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 01:28:11 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 01:28:11 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 01:28:11 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 01:28:12 INFO - Downloading functools32-3.2.3-2.tar.gz 01:28:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:28:12 INFO - warning: no files found matching '*.txt' 01:28:12 INFO - no previously-included directories found matching 'build' 01:28:12 INFO - no previously-included directories found matching 'dist' 01:28:12 INFO - no previously-included directories found matching '.git*' 01:28:12 INFO - Installing collected packages: jsonschema, functools32 01:28:12 INFO - Running setup.py install for functools32 01:28:12 INFO - warning: no files found matching '*.txt' 01:28:12 INFO - no previously-included directories found matching 'build' 01:28:12 INFO - no previously-included directories found matching 'dist' 01:28:12 INFO - no previously-included directories found matching '.git*' 01:28:12 INFO - Successfully installed jsonschema functools32 01:28:12 INFO - Cleaning up... 01:28:12 INFO - Return code: 0 01:28:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:28:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53fdc1cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x140d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, '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': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', '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 01:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:28:12 INFO - Using env: {'DISPLAY': ':0', 01:28:12 INFO - 'HOME': '/home/cltbld', 01:28:12 INFO - 'LANG': 'en_US.UTF-8', 01:28:12 INFO - 'LANGUAGE': 'en_US:en', 01:28:12 INFO - 'LOGNAME': 'cltbld', 01:28:12 INFO - 'MAIL': '/var/mail/cltbld', 01:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:12 INFO - 'MOZ_NO_REMOTE': '1', 01:28:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:12 INFO - 'NO_EM_RESTART': '1', 01:28:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:12 INFO - 'PWD': '/builds/slave/test', 01:28:12 INFO - 'SHELL': '/bin/bash', 01:28:12 INFO - 'SHLVL': '1', 01:28:12 INFO - 'TERM': 'linux', 01:28:12 INFO - 'TMOUT': '86400', 01:28:12 INFO - 'USER': 'cltbld', 01:28:12 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:12 INFO - '_': '/tools/buildbot/bin/python'} 01:28:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:28:12 INFO - Downloading/unpacking flake8 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:28:15 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 01:28:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:28:15 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 01:28:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 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 01:28:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:28:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:28:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:28:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:28:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:28:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:15 INFO - no previously-included directories found matching 'docs/_build' 01:28:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:28:16 INFO - Running setup.py install for pep8 01:28:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:28:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:28:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:28:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:28:16 INFO - no previously-included directories found matching 'docs/_build' 01:28:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:28:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:28:16 INFO - Cleaning up... 01:28:16 INFO - Return code: 0 01:28:16 INFO - Running post-action listener: _resource_record_post_action 01:28:16 INFO - Running post-action listener: _start_resource_monitoring 01:28:16 INFO - Starting resource monitoring. 01:28:16 INFO - ##### 01:28:16 INFO - ##### Running install step. 01:28:16 INFO - ##### 01:28:16 INFO - Running pre-action listener: _resource_record_pre_action 01:28:16 INFO - Running main action method: install 01:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:28:16 INFO - Reading from file tmpfile_stdout 01:28:16 INFO - Detecting whether we're running mozinstall >=1.0... 01:28:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:28:16 INFO - Reading from file tmpfile_stdout 01:28:16 INFO - Output received: 01:28:16 INFO - Usage: mozinstall [options] installer 01:28:16 INFO - Options: 01:28:16 INFO - -h, --help show this help message and exit 01:28:16 INFO - -d DEST, --destination=DEST 01:28:16 INFO - Directory to install application into. [default: 01:28:16 INFO - "/builds/slave/test"] 01:28:16 INFO - --app=APP Application being installed. [default: firefox] 01:28:16 INFO - mkdir: /builds/slave/test/build/application 01:28:16 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'] 01:28:16 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 01:28:31 INFO - Reading from file tmpfile_stdout 01:28:31 INFO - Output received: 01:28:31 INFO - /builds/slave/test/build/application/firefox/firefox 01:28:31 INFO - Running post-action listener: _resource_record_post_action 01:28:31 INFO - ##### 01:28:31 INFO - ##### Running run-tests step. 01:28:31 INFO - ##### 01:28:31 INFO - Running pre-action listener: _resource_record_pre_action 01:28:31 INFO - Running main action method: run_tests 01:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:28:31 INFO - Python 2.7.3 01:28:31 INFO - Return code: 0 01:28:31 INFO - grabbing minidump binary from tooltool 01:28:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:28:31 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 0x149c0b0>, '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 0x149cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:28:31 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 01:28:31 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 01:28:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:28:31 INFO - Return code: 0 01:28:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:28:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:28:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:28:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:28:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:28:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:28:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:28:32 INFO - Return code: 0 01:28:32 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/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test/build 01:28:32 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/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 01:28:32 INFO - Using env: {'DISPLAY': ':0', 01:28:32 INFO - 'HOME': '/home/cltbld', 01:28:32 INFO - 'LANG': 'en_US.UTF-8', 01:28:32 INFO - 'LANGUAGE': 'en_US:en', 01:28:32 INFO - 'LOGNAME': 'cltbld', 01:28:32 INFO - 'MAIL': '/var/mail/cltbld', 01:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:28:32 INFO - 'MOZ_NO_REMOTE': '1', 01:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:28:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:28:32 INFO - 'NO_EM_RESTART': '1', 01:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:28:32 INFO - 'PWD': '/builds/slave/test', 01:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:28:32 INFO - 'SHELL': '/bin/bash', 01:28:32 INFO - 'SHLVL': '1', 01:28:32 INFO - 'TERM': 'linux', 01:28:32 INFO - 'TMOUT': '86400', 01:28:32 INFO - 'USER': 'cltbld', 01:28:32 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716', 01:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:28:32 INFO - '_': '/tools/buildbot/bin/python'} 01:28:32 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/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 01:28:32 INFO - mozversion INFO | application_buildid: 20151203005925 01:28:32 INFO - mozversion INFO | application_changeset: 92499b34eeffbfdaf5df19f63c464988435356db 01:28:32 INFO - mozversion INFO | application_display_name: Nightly 01:28:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:28:32 INFO - mozversion INFO | application_name: Firefox 01:28:32 INFO - mozversion INFO | application_remotingname: firefox 01:28:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 01:28:32 INFO - mozversion INFO | application_vendor: Mozilla 01:28:32 INFO - mozversion INFO | application_version: 45.0a1 01:28:32 INFO - mozversion INFO | platform_buildid: 20151203005925 01:28:32 INFO - mozversion INFO | platform_changeset: 92499b34eeffbfdaf5df19f63c464988435356db 01:28:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 01:28:32 INFO - mozversion INFO | platform_version: 45.0a1 01:28:32 INFO - 2015-12-03 01:28:32,248 DEBUG : using testdate: 1449134912 01:28:32 INFO - 2015-12-03 01:28:32,248 DEBUG : actual date: 1449134912 01:28:32 INFO - 2015-12-03 01:28:32,256 INFO : starting webserver on 'localhost:37065' 01:28:32 INFO - 2015-12-03 01:28:32,257 INFO : Starting test suite talos-linux64-ix-042 01:28:32 INFO - 2015-12-03 01:28:32,257 INFO : Starting test dromaeo_css 01:28:32 INFO - 2015-12-03 01:28:32,257 DEBUG : operating with platform_type : linux_ 01:28:32 INFO - 2015-12-03 01:28:32,257 INFO : Initialising browser for dromaeo_css test... 01:28:32 INFO - 2015-12-03 01:28:32,264 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFF2JnW/profile http://localhost:37065/getInfo.html 01:28:36 INFO - 2015-12-03 01:28:36,891 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:28:36 INFO - 2015-12-03 01:28:36,891 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:28:36 INFO - 2015-12-03 01:28:36,891 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:28:36 INFO - 2015-12-03 01:28:36,891 DEBUG : BROWSER_OUTPUT: __metrics 01:28:37 INFO - 2015-12-03 01:28:37,012 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] 01:28:37 INFO - 2015-12-03 01:28:37,012 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] 01:28:37 INFO - 2015-12-03 01:28:37,984 INFO : Browser initialized. 01:28:37 INFO - 2015-12-03 01:28:37,985 INFO : Running cycle 1/1 for dromaeo_css test... 01:28:37 INFO - 2015-12-03 01:28:37,985 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFF2JnW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:28:49 INFO - 2015-12-03 01:28:49,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 143683584 01:28:49 INFO - 2015-12-03 01:28:49,998 DEBUG : BROWSER_OUTPUT: 01:29:41 INFO - 2015-12-03 01:29:41,136 DEBUG : BROWSER_OUTPUT: 1449134981134 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] 01:31:52 INFO - 2015-12-03 01:31:52,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37065/tests/dromaeo/cssquery-ext.html) 01:31:54 INFO - 2015-12-03 01:31:54,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 231800832 01:31:54 INFO - 2015-12-03 01:31:54,232 DEBUG : BROWSER_OUTPUT: 01:34:56 INFO - 2015-12-03 01:34:56,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/dromaeo/cssquery-ext.html (next: http://localhost:37065/tests/dromaeo/cssquery-jquery.html) 01:34:57 INFO - 2015-12-03 01:34:57,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 226746368 01:34:57 INFO - 2015-12-03 01:34:57,253 DEBUG : BROWSER_OUTPUT: 01:37:59 INFO - 2015-12-03 01:37:59,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37065/tests/dromaeo/cssquery-mootools.html) 01:37:59 INFO - 2015-12-03 01:37:59,851 DEBUG : BROWSER_OUTPUT: RSS: Main: 218308608 01:37:59 INFO - 2015-12-03 01:37:59,852 DEBUG : BROWSER_OUTPUT: 01:41:01 INFO - 2015-12-03 01:41:01,823 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37065/tests/dromaeo/cssquery-prototype.html) 01:41:02 INFO - 2015-12-03 01:41:02,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 202440704 01:41:02 INFO - 2015-12-03 01:41:02,409 DEBUG : BROWSER_OUTPUT: 01:44:05 INFO - 2015-12-03 01:44:05,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37065/tests/dromaeo/cssquery-yui.html) 01:44:05 INFO - 2015-12-03 01:44:05,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 180637696 01:44:05 INFO - 2015-12-03 01:44:05,891 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,511 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/dromaeo/cssquery-yui.html (next: http://localhost:37065/tests/dromaeo/cssquery-dojo.html) 01:47:08 INFO - 2015-12-03 01:47:08,757 DEBUG : BROWSER_OUTPUT: RSS: Main: 280633344 01:47:08 INFO - 2015-12-03 01:47:08,757 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,757 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:47:08 INFO - 2015-12-03 01:47:08,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:47:08 INFO - 2015-12-03 01:47:08,757 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:47:08 INFO - 2015-12-03 01:47:08,758 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:47:08 INFO - 2015-12-03 01:47:08,761 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2595.740425957404;2673.064427450394;2680.5845094010433;2688.7580117789394;2703.783697304216;4518.728876267426;4592.908141837162;4663.65022623303;4676.719396836188;4702.388689470368;4578.244589642713;4601.286800545912;4665.766711664412;4690.343351930724;4695.85912422627;4300.096979634272;4328.870133895973;4337.392765012901;4347.13057388522;4406.867793966187;4173.998240422307;4407.2948328267485;4411.360352748849;4455.688101832873;4462.352958820969;4232.936505952413;4282.550332215135;4286.142771445723;4311.094670119247;4323;4332.870013899588;4357.694961352707;4363;4381.342798580206;4402.031553058322;4360.934585981213;4362.040351122748;4363.912721745547;4374.365716971021;4418.469783625986;4375.059362237134;4493.505714371417;4499.550044995474;4526.117407105616;4615.053913947632;5011.2483127530795;5045.369328833895;5049.671771334852;5054.267131265946;5097.7960881564695;5069.290299358093;5069.670471419346;5074.3657042869645;5074.5432911037815;5116.846494605168;4557.977210113928;4655.255159174583;4681.648876334289;4682;4782.784774685148;5156.664816786897;5181.404138524118;5194.532492075731;5197.350331208599;5248.580113590903;4965.528274813887;4979.178435558165;4979.925301120486;4981.352424184905;5040.7731652075745;4769.379980602499;4890.266460031024;4893.975530122327;4929.014197160511;5008.949910500921;4988;4994.800207991712;4995.375578052744;5004.049230646238;5026.120428924996;4941.209406494943;4946.035523073038;4950.430700469492;4955.281484184773;4994.051130285234;3986.3422535281934;4051.331530297527;4093.774842383638;4169.854055108057;4212.136512015029;3590.425531914881;3628.2380700053286;3635.4910312556262;3652.945205821915;3684.926301474009;4324.1567894260315;4411.536788637147;4413.713108647928;4422.513523512411;4471.888202794956;4910.508949105132;5035.79856805731;5042.3444952156715;5132.8460146195675;5149.150390185652;4231.40760293553;4319.460067491564;4321.978390108029;4340.76125813077;4341.652667786632;4492.550744925481;4517.6160026397465;4518.480374756879;4518.977405113019;4565.338025986213;4867.537583929521;4869.4400143982475;4875.390576177978;4879.4876537963;4920.261960705922;4752.9049419010735;4863.805447782049;4869.147899117711;4952.5542701157065;5065.164247899055;4835.395575553056;4860.756962151808;4869.610431165427;4870.853874383774;4871.439784424837;5018.328153637676;5032.899342013213;5037.672551284155;5038.596912247085;5086.160783470686;4879.707217566957;4996.6002719783055;4998.775055122601;5083.339165908408;5101.056304583664;4783.402074740658;4859.635527335535;4863.562279394871;4865.781039853286;4903.705777653352;4842;4865.0999565079155;4888.095702295087;4891.119598472309;4901.705897646153;4610.585047345755;4691.390119284471;4702.717836929795;4780.641451891052;4820.662553621213;4791.161546729378;4949.529794669501;4974.502549745142;4982.676126051795;4996.875078123076;4834.5890599298045;4845.53967373099;4856.885563178834;4857.101436234308;4895.975520122377 01:47:08 INFO - 2015-12-03 01:47:08,762 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.2811073714905;558.1627558662004;590.4449817171861;591.7130191856949;600.3996003996004;28269.434611307763;37221.44167837481;37588.62411375885;37772;37841.62158378415;40351;40832.387514187234;40832.79583602078;40852.795736021355;40891;7070.469714771387;7183.461240406964;7987.640556174957;8142.389320800934;8163.95918020409;10167.983201679846;10529.15766738663;10534.841977370346;10537.47312634369;10538.420386878719;10097.444640544767;10207.591696332138;10209.642662506814;10215.131713804336;10223.846642300372;7319.5242309249725;7487;7488.5506869588;7509.286617771303;10184;10346.896531034668;10589.205809564313;10635.840462393071;10639.734006649818;10642.361458312525;37152.44271335932;37500.812495937345;37536.24927501435;37574.43638345427;37629;2862.084133077416;2900.5214139666928;2933.296008957856;3000.429918315513;3425.400554902882;28077.71922280792;28337.57493637597;28472;28531;29176.854115729497;3039.149038269288;3054.312779624589;3059.5104783234797;3124.2345625321714;3143.6070491188602;212668;212723;212745;213680;213744;50159.24761128586;50817.237741433906;53362.46637533575;54196.45803541993;54269.72865135649;54582.45417545853;54659.72670136624;54963.175552366745;54980;54996;14054.508092216724;14253.216073116078;14256.073355232083;14261.78607320891;14269.357878895475;10628.627998020032;10733;10736.409497477558;10817.350958942488;10859;17647.205875735624;17978.91010544965;18048;18066.3676771315;18131.18409671568;7231.3130252625915;7529.924700753032;7572.8485430292185;7603.0876294844975;7608.087029556488;840.8192238668715;844.4173520271116;856.2892798976834;864.6109250837022;915.1946287267295;23339.649905251434;23812.523749524913;24610;24671.50656986886;24759.3810154744;955.9665411710696;1004.0612027754073;1023.0383439566783;1040.2406243442329;1064.6007747094839;13141.802872956914;14007.229602371968;14523.491677791226;14726.779098313535;14817.555473335817;266205;272347;272799;273056;273701;45812.54187458083;46006.07987840224;46166.30750538745;46183.30725039127;46184.76907615441;1081.8269076947809;1246.526319998395;1250.9061820363509;1253.3482589053824;1266.1453518874723;19667.508312292306;26495.867520662272;26977.730222697523;29021.12936611905;29460.705392946653;40754;41230.38154427626;41315.38026929538;41315.7934210327;41327.58672413237;213156;213603;222957;226168;239669;26531.86734066317;26843.19470415891;26863.86568067147;27245;27309.453810924068;35038.29923401467;38435.6156438432;39508.40737388999;39534.604653953094;40450;31556.36887262288;33454.83272583621;33473.163170920925;36358.636413635526;36439.63560364363;31885.840570796998;32163.35673286568;32216;32694.509582355808;32776.67223327832;32823.19472428944;32870;33058;33340.666593334725;33455.83272083624;27294.317642059108;28883.5667464984;29475.74581191187;29610.259743506584;29901;22819.475147081015;23040;23470.64794028125;23523.882380587987;23623.40941476477 01:47:08 INFO - 2015-12-03 01:47:08,764 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.67034970554016;338.9084947064293;340.14453649072584;340.23447243701673;340.81255309579734;11945.701357466047;12354.752904941895;14978.625534361632;15059.17174555399;15844.049357038572;12897.484100635964;14985.400583976656;15004.699906001873;15263.389464421438;15355.232238388091;4093.9795301023455;4924.926126108102;5047.0915235257635;5096.133657278253;5113.488651134894;5026.447090820006;5032.094223039851;5041.72270525121;5046.21783623539;5052.545270925634;4996.575291100261;5000.624953128512;5003.899922001558;6430.7749228777;6734.090897728817;6583.868322633544;6611.338866113399;6613.437857782094;6620.073189753391;6620.238672552646;6251.78118765841;6503.804885853432;6504.38208370204;6505.512086593524;6507.414332710079;15476.148811815345;15621.609459763484;17201.311947522085;17876.28494860204;19427.4171774847;2044.8568600197991;2084.833213342929;2093.6336141175384;2109.4304537774715;2174.6737989301573;13320.733585328337;13664;13927.948577407882;13992.020558560906;14098.647533811736;1881.1816859665953;1882.8023057578894;1889.527618095476;1917.8657493975427;1973.4572992427197;60475.39524604742;64799.67600162016;64831;65114.674426627564;65594;14776.527516033724;15586.844131558539;15662.451814186448;15675.843241567667;15676.529704108894;18669.719954200697;19244.23023079089;22185.778142218693;23895.761042389702;23916.641250381257;8066.717664881701;8219.589020549069;8333.541655209021;8378.329733621296;8384.203500667549;6863.416609588141;6873.312668733087;6884.759033433906;6927;6949.548279361826;7566.886496702554;7577.924220757832;7592.772216833504;7611.238876112455;7655.157932627407;2929;2953.6898625644426;3013.608230929965;3049.344390955955;3056.1290032340676;786.5673879366326;831.2477208126655;840.5755093677653;904.9592768325441;957.2437774158476;15486.690266194839;15899.364025438854;16261;16423.343066277215;16522.75215871763;835.9038710548243;837.3134030095385;863.0851297624538;900.8828852249165;959.6737109382843;7229.638518074075;8637.179467950535;9264.44413335202;9294.256459483226;9532.714018579454;319676;319805;320910;321150;321263;62334;66427;72757.63621181861;72807.63596182091;73569.26430735731;1013.7516308504464;1049.9632512862165;1055.0188324857957;1058.5977328615077;1080.708208783624;13424.93287533556;13578.592642220749;13671.248081355621;13751.656208594864;13989.440422383397;28554.714452856035;29107.708922911348;29674.258143546584;29677.554836677034;29782.25544361408;37951.62048379481;39834.40248396334;39880.60119398769;41291;42562.78718606387;8213.95893020531;8307.252347288773;8536.91463085386;8561.828763424572;8696.91303086961;9933.602655893972;9935.552900119368;9983.15143212835;9985.1512621428;12416.441260143496;12422.503099875903;12532.436040378387;13115.737685246051;14076.718465630425;14158.716825663223;12841.29372884463;13358.532451364155;13361.66595835073;13513;13690.452381904612;13275.544024355526;13551.777925703544;13610;13944.4422223114;14618;8429.11494293115;8629.482231066157;8644.135586441305;8765.07966663491;8781.25359344463;9153.130452606993;9224.631014759334;13151.671208219872;13982.860171398563;14118.364673589918 01:47:08 INFO - 2015-12-03 01:47:08,767 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1233.7285797124641;1424.8361438434579;1482.4737218287507;1590.2048975512243;1741.1903464888833;6039.275286965565;6957.234704182536;7084.326988936049;7094.538854974436;7094.929050709491;7058.470614703892;7318.414526837853;7325.047743793312;7325.853482930338;7325.963370183155;2028.9086991085362;2079.9480012999643;2080.750309962799;2080.927167549136;2081.42760740796;2076.470500022492;2098.6012657595084;2101.338078505266;2121.63932131538;2128.17001369466;2063.865848719836;2104.3489545638304;2106.6208082545136;2137.732783402075;2139.283340081067;2029.1376165129761;2066.3077868913933;2081.9791802081936;2084.4267826347723;2084.7178984924312;2035.9287424940205;2077.968830467544;2079.4905248214286;2080.0847627044054;2086.6557018092;6045.274567051938;6279.058141278845;7155.212926578072;7274.236205198484;7282.563046217191;3967.6825853931905;4095.201435720036;4106.938395924063;4115.52671442785;4117.5882411758885;2629.5661215899354;2646.93382665433;2660.361513236809;2687.314734742628;2692.67687877454;825.8059356051323;839.4543546694697;845.3744229270358;847.8728190771373;848.2916764501648;9411.152996230303;9504.144626983605;9522.571484283155;9525.761855953588;9545.665901693477;3847.9807600962376;3848.518320446592;3900;3903.921921561553;3908.022994251437;8231.835363292821;8239.464434811838;8254.54599996994;8286.378521610903;8298.958505207556;4140.171965606891;4191.308434108338;4204.579542045771;4205.558416366299;4215.262329092458;3836.462895194675;3844;3845.3655146900446;3848.037990502374;3852.3451013327804;3250.9837450812593;3253.3168034712503;3280.8851690190727;3283.83580820958;3290.341931613639;1052.9631462898762;1053.378506681062;1054.7132498352153;1056.2131212246773;1057.2652006855162;1198.4726720243066;1205.81912713092;1208.522633559739;1228.0728050322127;1230.698478872682;6745.325467453215;6814.591124532544;6843.931560684429;6852.177738671391;6864.897026544606;389.42170876248747;392.162732565968;394.7236934146109;395.1523981060609;414.819553494231;4974.452810190948;5330.680159190461;5394.136938089887;5409.783608655688;5412.756425960842;7560.848783024308;8076.111627720946;8283.710070147516;8292.253697167283;8303.377246706521;8225.424220304521;8234.300084492885;8260.958695206486;8324.833503329899;8327.95836020816;6347.777827776005;6576.1122248496795;6580.86838263232;6602.603843769293;6650.733970641217;6681.46548276127;6716.865662686621;6734.73061077571;6772.55978361405;6788.287229840796;7232.855342893007;7453.031105956191;7455.0681164854395;7543.245675432413;7564.962175189309;7679.462437629312;7885.369170466234;7904.84190316202;7931.801704957422;8016.83966320682;6278;6286.685665716787;6328.778492752732;6339.809805705836;6354.555181137276;6676.098726672031;6711.731530738911;6747.527673063035;6793.150856142982;6818.488613354118;6397.584157029778;6484.967575162094;6500.057491663588;6568.244651865097;6584.407403333723;6337.90493142594;6436.13112229843;6488.70800813974;6493.805185844432;6540.117084193573;6562.507811914221;6581.703823327866;6635.8009259722285;6638.900416493853;6652.434543063894;5705.372409035086;5817.243758311392;5818.4763371296785;6034.607750496204;6089.786857459968;6002.969985150046;6045.818625441244;6048.183495228088;6063.575549711654;6065.636061836304 01:47:08 INFO - 2015-12-03 01:47:08,768 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.24343194558037;301.1252312033542;303.0877060049251;305.2627903612774;306.0573433823822;5254.7635356408955;5306.336707911511;5373.113436283018;5405.540529055035;5424.566034717223;5287.894242115165;5298.867528311785;5314.734263286829;5325.920111198326;5334.626576139672;3909.9609003910023;4166.208420400129;4171.749695018293;4174.248635245654;4178.080822219107;4009.719319647626;4048.251073551388;4136.772477513736;4167.520735115455;4187.057911969798;4107.650849677781;4114.567970363114;4120.093579412524;4140.0891803803115;4140.23405669952;3891.377379619247;3971.702122340807;4017.4174744662155;4123.773192474413;4125.4843144607075;3606.9819650901577;3630.16506203572;3635.6909662678704;3641.799701016443;3644.3804553226014;5102.285680004802;5105.897882042338;5108.055009823194;5117.897642047138;5119.078565858144;4745.264484004951;4747.643926705477;4750.667453278272;4751.31105989633;4761.26200438929;5436.786490469917;5582.190582365575;5586.441355864422;5590.5527557795685;5599.104143337087;3952.7628342299554;3954.62431069048;3958.5645578986287;3959.208158368338;3959.544652364986;5874.060150375919;5893.351731309553;5894.17481552583;5895.4399332063385;5896.321922978869;4087.2847251730827;4093.7543747375253;4094.672426205956;4094.8566800161852;4096.1193343431305;3692.649198326155;3878.553966293856;4159.83360665576;4160.9805597628165;4165.8541951032175;4452.265376212953;4539.228331183706;4574.4968053514085;4601.539846015372;4689.62483001359;5561.5272701820795;5592.217089607459;5593.133064375028;5597.720113994284;5598.1602759586385;1410.3935307817737;1432.9713405731827;1433.9498117566043;1434.103685196752;1436.0737324425686;953.5661274120258;958.2094771813282;961.7595601099725;979.8285300072458;980.4019548075668;4938.777755001033;4943.9258411123865;4949.628777841676;4953.43035550909;4959.429665588431;5820.35976042635;5820.70896455184;5826.737796799154;5829.562782791223;5838.511179649162;4882.804687812519;4916.164252077156;4927.260910863399;4930.556249937523;4932.334134891816;3057.480228361184;3095.7059079387423;3124.765642576816;3127.640321363027;3136.780425370202;5583.134614134816;5586.832395028156;5591.4688104629995;5597.524210442158;5598.86002849932;6013.338532761392;6022.939770602326;6037.215162028908;6045.879082418415;6047.395260473917;5598.944010559842;5600.159976003632;5601.075822489243;5604.467575580314;5606.55147588192;5819.82540523785;5858.384869588632;5867.383924687846;5876.412358764261;5877.500412464818;5721.971390143022;5722.484976352148;5731.914021289601;5734.569907256889;5737.56968227393;5557.138643510262;5586.273784408001;5586.636868603528;5594.468525490072;5597.384287728265;3884.18432129256;3950.3481925483125;3989.640932315989;3998.7800670963375;3999.7600143991453;5762.135679648086;5833.562482813891;5845.590808643524;5854.970725146347;5858.8242352729485;5610.691411972381;5615.7192140392;5618.943810561842;5622.100463925753;5628.63413878113;5497.423859635137;5604.075327570905;5608.943910560843;5611.663300202001;5617.32592088952;5431.456854314537;5471.124620060771;5478.780848766005;5488.890222195454;5489.149181876815;5462;5611.270534830446;5652.547796176378;5653.180288858175;5660.7169641518585;5406.459354064562;5525.281713377235;5527.806526771544;5540.279763630702;5548.667079975215 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: |5;yui.html;770.9653065612047;778.6768491076203;791.3589992106395;808.7088648086687;831.8918540589723;12297.938510307447;12570.685732856671;12615.05387095967;12632.178908370972;12662.176958497692;13460.46158153675;13536;13553.52562660307;13561.93219033906;13566.728665426686;628.1896353703717;636.6021236727046;819.8729196974479;834.1825011488745;834.9624266908004;803.7307501986842;811.809224832164;819.1235378145357;820.1142765812908;820.1142765812908;854.2567965869702;862.0216054777841;862.2196911794805;862.3661608717588;862.5514732339179;654.3162395296903;662.7216569041015;845.5349557743217;849.0914721248267;862.6592495964122;634.3244444666416;636.7930422612623;638.2373064188297;638.3807706524664;638.4094712391067;11910.880891191064;12099.87900121005;12119.697007574881;12129.150959432844;12135.817962730478;11036.392998385085;11086.667399977932;11296.435178241138;11380.089592832637;11772.99929505993;9342.252619790468;9558.90441095594;9575.138237558653;9761.267904907088;9771.316007879452;3119.173419043955;3173.0480855743417;3186.522021696741;3214.100051985448;3218.163277547831;41119.588804111874;41416;41570.58429415728;41587.37618935719;41689.1662166755;9079.455232685928;9262.444253344685;9302.395344302735;9343.159115679622;9367.906320936703;16171.353145874033;16213.189340532927;16232.75650865238;16242.51272461828;16250.918745406198;6277.811665650038;6294;6348.269948955837;6354.110424540568;6543.083968244449;3637.745357824927;3641.9453708194396;3682.760620559655;3727.6645101940953;3739.0652336915773;2747.189579074178;2794.9720502795117;2803.355228297503;2808.845513496777;3001.9249518762203;548.3282978351488;549.2996429552273;561.4217356123199;563.3352643880261;568.1619611073634;477.79216041021573;556.326849488205;616.2050954269032;618.1284389011472;630.0895206426761;7510.774676759596;7568.053993250844;7644.961775191088;7813.296803287732;7869.803254918558;488.30904270456904;556.8524341049625;582.1093726598311;582.7406803972276;590.4420322794917;3539.50446937429;3568.57177138745;3772.9434058489146;3800.657940785343;3837.501124853751;49080.26379604309;49970.75014624903;50079.749601252486;54578.18132728012;54919;44703.32945005828;45001;45745;45882;46428;42115;42362.788186058875;42628.57371426308;43224.351634725506;43376.3493547597;7589.354904833151;8195.95902020486;8243.197312913639;8322.875156872773;8368.7907802303;31655.84172079125;32222;32558.34883302368;32946.5058024125;33008.53410391874;37661.435078474395;41770;41986.58013419949;42143;42219.36670949877;9956.601735930482;9983.60065597368;10014.899851001397;10060.597576096874;10064.295499314978;10564.788704226026;10604.681859544226;11043.337399756041;11463.31220126795;11542.076633869103;10745;11362.943185284352;11488.712782180512;11747.47136378848;11901.464434100313;9084.227840633355;9488.525573721425;10650.201234907257;10938.12495000414;11138.498767555642;9674.95162524211;10721.678349649523;11323;11402.372869491926;11580.594679186188;9051.59267832936;9115.453072815651;9271.490068046322;9273.67542136022;9525.571349289437;8755.299576034029;9525.857112143185;9592.616295348107;9609.039096090335;9720.708378748648 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1056 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: __startTimestamp1449136028756__endTimestamp 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:47:08 INFO - 2015-12-03 01:47:08,769 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,770 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4637.55 Median:4791.16 stddev:490.09 (10.2%) stddev-sans-first:464.68 01:47:08 INFO - 2015-12-03 01:47:08,771 DEBUG : BROWSER_OUTPUT: Values: 2595.7 2673.1 2680.6 2688.8 2703.8 4518.7 4592.9 4663.7 4676.7 4702.4 4578.2 4601.3 4665.8 4690.3 4695.9 4300.1 4328.9 4337.4 4347.1 4406.9 4174.0 4407.3 4411.4 4455.7 4462.4 4232.9 4282.6 4286.1 4311.1 4323.0 4332.9 4357.7 4363.0 4381.3 4402.0 4360.9 4362.0 4363.9 4374.4 4418.5 4375.1 4493.5 4499.6 4526.1 4615.1 5011.2 5045.4 5049.7 5054.3 5097.8 5069.3 5069.7 5074.4 5074.5 5116.8 4558.0 4655.3 4681.6 4682.0 4782.8 5156.7 5181.4 5194.5 5197.4 5248.6 4965.5 4979.2 4979.9 4981.4 5040.8 4769.4 4890.3 4894.0 4929.0 5008.9 4988.0 4994.8 4995.4 5004.0 5026.1 4941.2 4946.0 4950.4 4955.3 4994.1 3986.3 4051.3 4093.8 4169.9 4212.1 3590.4 3628.2 3635.5 3652.9 3684.9 4324.2 4411.5 4413.7 4422.5 4471.9 4910.5 5035.8 5042.3 5132.8 5149.2 4231.4 4319.5 4322.0 4340.8 4341.7 4492.6 4517.6 4518.5 4519.0 4565.3 4867.5 4869.4 4875.4 4879.5 4920.3 4752.9 4863.8 4869.1 4952.6 5065.2 4835.4 4860.8 4869.6 4870.9 4871.4 5018.3 5032.9 5037.7 5038.6 5086.2 4879.7 4996.6 4998.8 5083.3 5101.1 4783.4 4859.6 4863.6 4865.8 4903.7 4842.0 4865.1 4888.1 4891.1 4901.7 4610.6 4691.4 4702.7 4780.6 4820.7 4791.2 4949.5 4974.5 4982.7 4996.9 4834.6 4845.5 4856.9 4857.1 4896.0 01:47:08 INFO - 2015-12-03 01:47:08,771 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,771 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39849.08 Median:29468.23 stddev:61694.82 (209.4%) stddev-sans-first:61797.35 01:47:08 INFO - 2015-12-03 01:47:08,771 DEBUG : BROWSER_OUTPUT: Values: 557.3 558.2 590.4 591.7 600.4 28269.4 37221.4 37588.6 37772.0 37841.6 40351.0 40832.4 40832.8 40852.8 40891.0 7070.5 7183.5 7987.6 8142.4 8164.0 10168.0 10529.2 10534.8 10537.5 10538.4 10097.4 10207.6 10209.6 10215.1 10223.8 7319.5 7487.0 7488.6 7509.3 10184.0 10346.9 10589.2 10635.8 10639.7 10642.4 37152.4 37500.8 37536.2 37574.4 37629.0 2862.1 2900.5 2933.3 3000.4 3425.4 28077.7 28337.6 28472.0 28531.0 29176.9 3039.1 3054.3 3059.5 3124.2 3143.6 212668.0 212723.0 212745.0 213680.0 213744.0 50159.2 50817.2 53362.5 54196.5 54269.7 54582.5 54659.7 54963.2 54980.0 54996.0 14054.5 14253.2 14256.1 14261.8 14269.4 10628.6 10733.0 10736.4 10817.4 10859.0 17647.2 17978.9 18048.0 18066.4 18131.2 7231.3 7529.9 7572.8 7603.1 7608.1 840.8 844.4 856.3 864.6 915.2 23339.6 23812.5 24610.0 24671.5 24759.4 956.0 1004.1 1023.0 1040.2 1064.6 13141.8 14007.2 14523.5 14726.8 14817.6 266205.0 272347.0 272799.0 273056.0 273701.0 45812.5 46006.1 46166.3 46183.3 46184.8 1081.8 1246.5 1250.9 1253.3 1266.1 19667.5 26495.9 26977.7 29021.1 29460.7 40754.0 41230.4 41315.4 41315.8 41327.6 213156.0 213603.0 222957.0 226168.0 239669.0 26531.9 26843.2 26863.9 27245.0 27309.5 35038.3 38435.6 39508.4 39534.6 40450.0 31556.4 33454.8 33473.2 36358.6 36439.6 31885.8 32163.4 32216.0 32694.5 32776.7 32823.2 32870.0 33058.0 33340.7 33455.8 27294.3 28883.6 29475.7 29610.3 29901.0 22819.5 23040.0 23470.6 23523.9 23623.4 01:47:08 INFO - 2015-12-03 01:47:08,771 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,771 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22241.53 Median:339.53 stddev:52817.10 (15556.1%) stddev-sans-first:52939.65 01:47:08 INFO - 2015-12-03 01:47:08,772 DEBUG : BROWSER_OUTPUT: Values: 334.7 338.9 340.1 340.2 340.8 11945.7 12354.8 14978.6 15059.2 15844.0 12897.5 14985.4 15004.7 15263.4 15355.2 4094.0 4924.9 5047.1 5096.1 5113.5 5026.4 5032.1 5041.7 5046.2 5052.5 4996.6 5000.6 5003.9 6430.8 6734.1 6583.9 6611.3 6613.4 6620.1 6620.2 6251.8 6503.8 6504.4 6505.5 6507.4 15476.1 15621.6 17201.3 17876.3 19427.4 2044.9 2084.8 2093.6 2109.4 2174.7 13320.7 13664.0 13927.9 13992.0 14098.6 1881.2 1882.8 1889.5 1917.9 1973.5 60475.4 64799.7 64831.0 65114.7 65594.0 14776.5 15586.8 15662.5 15675.8 15676.5 18669.7 19244.2 22185.8 23895.8 23916.6 8066.7 8219.6 8333.5 8378.3 8384.2 6863.4 6873.3 6884.8 6927.0 6949.5 7566.9 7577.9 7592.8 7611.2 7655.2 2929.0 2953.7 3013.6 3049.3 3056.1 786.6 831.2 840.6 905.0 957.2 15486.7 15899.4 16261.0 16423.3 16522.8 835.9 837.3 863.1 900.9 959.7 7229.6 8637.2 9264.4 9294.3 9532.7 319676.0 319805.0 320910.0 321150.0 321263.0 62334.0 66427.0 72757.6 72807.6 73569.3 1013.8 1050.0 1055.0 1058.6 1080.7 13424.9 13578.6 13671.2 13751.7 13989.4 28554.7 29107.7 29674.3 29677.6 29782.3 37951.6 39834.4 39880.6 41291.0 42562.8 8214.0 8307.3 8536.9 8561.8 8696.9 9933.6 9935.6 9983.2 9985.2 12416.4 12422.5 12532.4 13115.7 14076.7 14158.7 12841.3 13358.5 13361.7 13513.0 13690.5 13275.5 13551.8 13610.0 13944.4 14618.0 8429.1 8629.5 8644.1 8765.1 8781.3 9153.1 9224.6 13151.7 13982.9 14118.4 01:47:08 INFO - 2015-12-03 01:47:08,772 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,772 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4938.23 Median:6077.71 stddev:2568.64 (42.3%) stddev-sans-first:2560.75 01:47:08 INFO - 2015-12-03 01:47:08,773 DEBUG : BROWSER_OUTPUT: Values: 1233.7 1424.8 1482.5 1590.2 1741.2 6039.3 6957.2 7084.3 7094.5 7094.9 7058.5 7318.4 7325.0 7325.9 7326.0 2028.9 2079.9 2080.8 2080.9 2081.4 2076.5 2098.6 2101.3 2121.6 2128.2 2063.9 2104.3 2106.6 2137.7 2139.3 2029.1 2066.3 2082.0 2084.4 2084.7 2035.9 2078.0 2079.5 2080.1 2086.7 6045.3 6279.1 7155.2 7274.2 7282.6 3967.7 4095.2 4106.9 4115.5 4117.6 2629.6 2646.9 2660.4 2687.3 2692.7 825.8 839.5 845.4 847.9 848.3 9411.2 9504.1 9522.6 9525.8 9545.7 3848.0 3848.5 3900.0 3903.9 3908.0 8231.8 8239.5 8254.5 8286.4 8299.0 4140.2 4191.3 4204.6 4205.6 4215.3 3836.5 3844.0 3845.4 3848.0 3852.3 3251.0 3253.3 3280.9 3283.8 3290.3 1053.0 1053.4 1054.7 1056.2 1057.3 1198.5 1205.8 1208.5 1228.1 1230.7 6745.3 6814.6 6843.9 6852.2 6864.9 389.4 392.2 394.7 395.2 414.8 4974.5 5330.7 5394.1 5409.8 5412.8 7560.8 8076.1 8283.7 8292.3 8303.4 8225.4 8234.3 8261.0 8324.8 8328.0 6347.8 6576.1 6580.9 6602.6 6650.7 6681.5 6716.9 6734.7 6772.6 6788.3 7232.9 7453.0 7455.1 7543.2 7565.0 7679.5 7885.4 7904.8 7931.8 8016.8 6278.0 6286.7 6328.8 6339.8 6354.6 6676.1 6711.7 6747.5 6793.2 6818.5 6397.6 6485.0 6500.1 6568.2 6584.4 6337.9 6436.1 6488.7 6493.8 6540.1 6562.5 6581.7 6635.8 6638.9 6652.4 5705.4 5817.2 5818.5 6034.6 6089.8 6003.0 6045.8 6048.2 6063.6 6065.6 01:47:08 INFO - 2015-12-03 01:47:08,773 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,773 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4658.46 Median:5330.27 stddev:1377.84 (25.8%) stddev-sans-first:1342.19 01:47:08 INFO - 2015-12-03 01:47:08,773 DEBUG : BROWSER_OUTPUT: Values: 293.2 301.1 303.1 305.3 306.1 5254.8 5306.3 5373.1 5405.5 5424.6 5287.9 5298.9 5314.7 5325.9 5334.6 3910.0 4166.2 4171.7 4174.2 4178.1 4009.7 4048.3 4136.8 4167.5 4187.1 4107.7 4114.6 4120.1 4140.1 4140.2 3891.4 3971.7 4017.4 4123.8 4125.5 3607.0 3630.2 3635.7 3641.8 3644.4 5102.3 5105.9 5108.1 5117.9 5119.1 4745.3 4747.6 4750.7 4751.3 4761.3 5436.8 5582.2 5586.4 5590.6 5599.1 3952.8 3954.6 3958.6 3959.2 3959.5 5874.1 5893.4 5894.2 5895.4 5896.3 4087.3 4093.8 4094.7 4094.9 4096.1 3692.6 3878.6 4159.8 4161.0 4165.9 4452.3 4539.2 4574.5 4601.5 4689.6 5561.5 5592.2 5593.1 5597.7 5598.2 1410.4 1433.0 1433.9 1434.1 1436.1 953.6 958.2 961.8 979.8 980.4 4938.8 4943.9 4949.6 4953.4 4959.4 5820.4 5820.7 5826.7 5829.6 5838.5 4882.8 4916.2 4927.3 4930.6 4932.3 3057.5 3095.7 3124.8 3127.6 3136.8 5583.1 5586.8 5591.5 5597.5 5598.9 6013.3 6022.9 6037.2 6045.9 6047.4 5598.9 5600.2 5601.1 5604.5 5606.6 5819.8 5858.4 5867.4 5876.4 5877.5 5722.0 5722.5 5731.9 5734.6 5737.6 5557.1 5586.3 5586.6 5594.5 5597.4 3884.2 3950.3 3989.6 3998.8 3999.8 5762.1 5833.6 5845.6 5855.0 5858.8 5610.7 5615.7 5618.9 5622.1 5628.6 5497.4 5604.1 5608.9 5611.7 5617.3 5431.5 5471.1 5478.8 5488.9 5489.1 5462.0 5611.3 5652.5 5653.2 5660.7 5406.5 5525.3 5527.8 5540.3 5548.7 01:47:08 INFO - 2015-12-03 01:47:08,773 DEBUG : BROWSER_OUTPUT: 01:47:08 INFO - 2015-12-03 01:47:08,773 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12612.00 Median:483.05 stddev:14335.45 (2967.7%) stddev-sans-first:14348.09 01:47:08 INFO - 2015-12-03 01:47:08,774 DEBUG : BROWSER_OUTPUT: Values: 771.0 778.7 791.4 808.7 831.9 12297.9 12570.7 12615.1 12632.2 12662.2 13460.5 13536.0 13553.5 13561.9 13566.7 628.2 636.6 819.9 834.2 835.0 803.7 811.8 819.1 820.1 820.1 854.3 862.0 862.2 862.4 862.6 654.3 662.7 845.5 849.1 862.7 634.3 636.8 638.2 638.4 638.4 11910.9 12099.9 12119.7 12129.2 12135.8 11036.4 11086.7 11296.4 11380.1 11773.0 9342.3 9558.9 9575.1 9761.3 9771.3 3119.2 3173.0 3186.5 3214.1 3218.2 41119.6 41416.0 41570.6 41587.4 41689.2 9079.5 9262.4 9302.4 9343.2 9367.9 16171.4 16213.2 16232.8 16242.5 16250.9 6277.8 6294.0 6348.3 6354.1 6543.1 3637.7 3641.9 3682.8 3727.7 3739.1 2747.2 2795.0 2803.4 2808.8 3001.9 548.3 549.3 561.4 563.3 568.2 477.8 556.3 616.2 618.1 630.1 7510.8 7568.1 7645.0 7813.3 7869.8 488.3 556.9 582.1 582.7 590.4 3539.5 3568.6 3772.9 3800.7 3837.5 49080.3 49970.8 50079.7 54578.2 54919.0 44703.3 45001.0 45745.0 45882.0 46428.0 42115.0 42362.8 42628.6 43224.4 43376.3 7589.4 8196.0 8243.2 8322.9 8368.8 31655.8 32222.0 32558.3 32946.5 33008.5 37661.4 41770.0 41986.6 42143.0 42219.4 9956.6 9983.6 10014.9 10060.6 10064.3 10564.8 10604.7 11043.3 11463.3 11542.1 10745.0 11362.9 11488.7 11747.5 11901.5 9084.2 9488.5 10650.2 10938.1 11138.5 9675.0 10721.7 11323.0 11402.4 11580.6 9051.6 9115.5 9271.5 9273.7 9525.6 8755.3 9525.9 9592.6 9609.0 9720.7 01:47:08 INFO - 2015-12-03 01:47:08,774 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:47:08 INFO - 2015-12-03 01:47:08,774 DEBUG : BROWSER_OUTPUT: 01:47:09 INFO - 2015-12-03 01:47:09,548 INFO : Browser exited with error code: 0 01:47:09 INFO - 2015-12-03 01:47:09,566 INFO : Completed test dromaeo_css (00:18:37) 01:47:09 INFO - 2015-12-03 01:47:09,566 INFO : Starting test kraken 01:47:09 INFO - 2015-12-03 01:47:09,566 DEBUG : operating with platform_type : linux_ 01:47:09 INFO - 2015-12-03 01:47:09,567 INFO : Initialising browser for kraken test... 01:47:09 INFO - 2015-12-03 01:47:09,573 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYhJZHi/profile http://localhost:37065/getInfo.html 01:47:13 INFO - 2015-12-03 01:47:13,789 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:47:13 INFO - 2015-12-03 01:47:13,789 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:47:13 INFO - 2015-12-03 01:47:13,789 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:47:13 INFO - 2015-12-03 01:47:13,789 DEBUG : BROWSER_OUTPUT: __metrics 01:47:13 INFO - 2015-12-03 01:47:13,873 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] 01:47:13 INFO - 2015-12-03 01:47:13,875 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] 01:47:15 INFO - 2015-12-03 01:47:15,193 INFO : Browser initialized. 01:47:15 INFO - 2015-12-03 01:47:15,193 INFO : Running cycle 1/1 for kraken test... 01:47:15 INFO - 2015-12-03 01:47:15,194 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYhJZHi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:47:27 INFO - 2015-12-03 01:47:27,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 143335424 01:47:27 INFO - 2015-12-03 01:47:27,182 DEBUG : BROWSER_OUTPUT: 01:47:29 INFO - 2015-12-03 01:47:29,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37065/tests/kraken/driver.html?testName=audio-beat-detection) 01:47:30 INFO - 2015-12-03 01:47:30,379 DEBUG : BROWSER_OUTPUT: RSS: Main: 183099392 01:47:30 INFO - 2015-12-03 01:47:30,379 DEBUG : BROWSER_OUTPUT: 01:47:33 INFO - 2015-12-03 01:47:33,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37065/tests/kraken/driver.html?testName=audio-dft) 01:47:33 INFO - 2015-12-03 01:47:33,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 172609536 01:47:33 INFO - 2015-12-03 01:47:33,740 DEBUG : BROWSER_OUTPUT: 01:47:36 INFO - 2015-12-03 01:47:36,720 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37065/tests/kraken/driver.html?testName=audio-fft) 01:47:37 INFO - 2015-12-03 01:47:37,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 156467200 01:47:37 INFO - 2015-12-03 01:47:37,286 DEBUG : BROWSER_OUTPUT: 01:47:39 INFO - 2015-12-03 01:47:39,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37065/tests/kraken/driver.html?testName=audio-oscillator) 01:47:39 INFO - 2015-12-03 01:47:39,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 154869760 01:47:39 INFO - 2015-12-03 01:47:39,898 DEBUG : BROWSER_OUTPUT: 01:47:42 INFO - 2015-12-03 01:47:42,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:47:42 INFO - 2015-12-03 01:47:42,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 157569024 01:47:42 INFO - 2015-12-03 01:47:42,709 DEBUG : BROWSER_OUTPUT: 01:47:45 INFO - 2015-12-03 01:47:45,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37065/tests/kraken/driver.html?testName=imaging-darkroom) 01:47:46 INFO - 2015-12-03 01:47:46,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 157831168 01:47:46 INFO - 2015-12-03 01:47:46,280 DEBUG : BROWSER_OUTPUT: 01:47:49 INFO - 2015-12-03 01:47:49,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37065/tests/kraken/driver.html?testName=imaging-desaturate) 01:47:50 INFO - 2015-12-03 01:47:50,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 158187520 01:47:50 INFO - 2015-12-03 01:47:50,215 DEBUG : BROWSER_OUTPUT: 01:47:53 INFO - 2015-12-03 01:47:53,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37065/tests/kraken/driver.html?testName=json-parse-financial) 01:47:53 INFO - 2015-12-03 01:47:53,615 DEBUG : BROWSER_OUTPUT: RSS: Main: 158154752 01:47:53 INFO - 2015-12-03 01:47:53,615 DEBUG : BROWSER_OUTPUT: 01:47:55 INFO - 2015-12-03 01:47:55,385 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:47:55 INFO - 2015-12-03 01:47:55,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 168628224 01:47:55 INFO - 2015-12-03 01:47:55,950 DEBUG : BROWSER_OUTPUT: 01:47:57 INFO - 2015-12-03 01:47:57,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:47:58 INFO - 2015-12-03 01:47:58,443 DEBUG : BROWSER_OUTPUT: RSS: Main: 166604800 01:47:58 INFO - 2015-12-03 01:47:58,444 DEBUG : BROWSER_OUTPUT: 01:48:00 INFO - 2015-12-03 01:48:00,580 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:48:01 INFO - 2015-12-03 01:48:01,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 181657600 01:48:01 INFO - 2015-12-03 01:48:01,161 DEBUG : BROWSER_OUTPUT: 01:48:03 INFO - 2015-12-03 01:48:03,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:48:04 INFO - 2015-12-03 01:48:04,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 184410112 01:48:04 INFO - 2015-12-03 01:48:04,297 DEBUG : BROWSER_OUTPUT: 01:48:06 INFO - 2015-12-03 01:48:06,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:48:07 INFO - 2015-12-03 01:48:07,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 182525952 01:48:07 INFO - 2015-12-03 01:48:07,478 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,228 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37065/tests/kraken/driver.html?testName=ai-astar) 01:48:09 INFO - 2015-12-03 01:48:09,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 240513024 01:48:09 INFO - 2015-12-03 01:48:09,478 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,481 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:48:09 INFO - 2015-12-03 01:48:09,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:48:09 INFO - 2015-12-03 01:48:09,482 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:48:09 INFO - 2015-12-03 01:48:09,482 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:48:09 INFO - 2015-12-03 01:48:09,482 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;110;105;110;109;110;100;110;110;104 01:48:09 INFO - 2015-12-03 01:48:09,482 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;148;164;168;146;153;161;131;173;135 01:48:09 INFO - 2015-12-03 01:48:09,483 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;160;161;159;160;159;161;160;160;160 01:48:09 INFO - 2015-12-03 01:48:09,483 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;93;90;70;72;71;118;92;72 01:48:09 INFO - 2015-12-03 01:48:09,483 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;94;95;94;132;95;94;132 01:48:09 INFO - 2015-12-03 01:48:09,483 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;110;109;110;109;110 01:48:09 INFO - 2015-12-03 01:48:09,484 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;147;146;148;146 01:48:09 INFO - 2015-12-03 01:48:09,484 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;95;95;95;96;95 01:48:09 INFO - 2015-12-03 01:48:09,484 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;70;72;71;70;80;68;68 01:48:09 INFO - 2015-12-03 01:48:09,484 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;67;68;69;68;69;68;68;69 01:48:09 INFO - 2015-12-03 01:48:09,485 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;83;82;85;82;84;84;83;82 01:48:09 INFO - 2015-12-03 01:48:09,485 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;120;127;119;122;126;129;128;127;126 01:48:09 INFO - 2015-12-03 01:48:09,485 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;149;142;154;149;139;139;154;146;144;133 01:48:09 INFO - 2015-12-03 01:48:09,485 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;71;72;70;70;71;70;71;69;68 01:48:09 INFO - 2015-12-03 01:48:09,485 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:48:09 INFO - 2015-12-03 01:48:09,486 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:48:09 INFO - 2015-12-03 01:48:09,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,988 01:48:09 INFO - 2015-12-03 01:48:09,486 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:48:09 INFO - 2015-12-03 01:48:09,486 DEBUG : BROWSER_OUTPUT: __startTimestamp1449136089480__endTimestamp 01:48:09 INFO - 2015-12-03 01:48:09,487 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,488 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:48:09 INFO - 2015-12-03 01:48:09,488 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:48:09 INFO - 2015-12-03 01:48:09,488 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,488 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.80 Median:110.00 stddev:3.55 (3.2%) stddev-sans-first:3.68 01:48:09 INFO - 2015-12-03 01:48:09,488 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 105.0 110.0 109.0 110.0 100.0 110.0 110.0 104.0 01:48:09 INFO - 2015-12-03 01:48:09,488 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:154.10 Median:161.50 stddev:13.99 (8.7%) stddev-sans-first:14.54 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: Values: 162.0 148.0 164.0 168.0 146.0 153.0 161.0 131.0 173.0 135.0 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.30 Median:160.00 stddev:1.16 (0.7%) stddev-sans-first:0.71 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: Values: 163.0 160.0 161.0 159.0 160.0 159.0 161.0 160.0 160.0 160.0 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,489 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.20 Median:72.50 stddev:15.80 (21.8%) stddev-sans-first:16.23 01:48:09 INFO - 2015-12-03 01:48:09,490 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 93.0 90.0 70.0 72.0 71.0 118.0 92.0 72.0 01:48:09 INFO - 2015-12-03 01:48:09,490 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.50 Median:94.00 stddev:18.06 (19.2%) stddev-sans-first:18.67 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 94.0 95.0 94.0 132.0 95.0 94.0 132.0 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 148.0 146.0 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,491 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.10 Median:71.00 stddev:3.38 (4.8%) stddev-sans-first:3.59 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 72.0 71.0 70.0 80.0 68.0 68.0 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 67.0 68.0 69.0 68.0 69.0 68.0 68.0 69.0 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.23 (1.5%) stddev-sans-first:1.12 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 83.0 82.0 85.0 82.0 84.0 84.0 83.0 82.0 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,492 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:126.50 stddev:3.75 (3.0%) stddev-sans-first:3.62 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: Values: 120.0 120.0 127.0 119.0 122.0 126.0 129.0 128.0 127.0 126.0 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:147.50 stddev:6.84 (4.6%) stddev-sans-first:7.09 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: Values: 149.0 142.0 154.0 149.0 139.0 139.0 154.0 146.0 144.0 133.0 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.50 stddev:1.33 (1.9%) stddev-sans-first:1.20 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 72.0 70.0 70.0 71.0 70.0 71.0 69.0 68.0 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:48:09 INFO - 2015-12-03 01:48:09,493 DEBUG : BROWSER_OUTPUT: 01:48:10 INFO - 2015-12-03 01:48:10,384 INFO : Browser exited with error code: 0 01:48:10 INFO - 2015-12-03 01:48:10,439 INFO : Completed test kraken (00:01:00) 01:48:10 INFO - 2015-12-03 01:48:10,440 INFO : Starting test v8_7 01:48:10 INFO - 2015-12-03 01:48:10,440 DEBUG : operating with platform_type : linux_ 01:48:10 INFO - 2015-12-03 01:48:10,440 INFO : Initialising browser for v8_7 test... 01:48:10 INFO - 2015-12-03 01:48:10,446 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaByA1W/profile http://localhost:37065/getInfo.html 01:48:14 INFO - 2015-12-03 01:48:14,850 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:48:14 INFO - 2015-12-03 01:48:14,850 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:48:14 INFO - 2015-12-03 01:48:14,850 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:48:14 INFO - 2015-12-03 01:48:14,850 DEBUG : BROWSER_OUTPUT: __metrics 01:48:15 INFO - 2015-12-03 01:48:15,007 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] 01:48:15 INFO - 2015-12-03 01:48:15,007 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] 01:48:16 INFO - 2015-12-03 01:48:16,317 INFO : Browser initialized. 01:48:16 INFO - 2015-12-03 01:48:16,317 INFO : Running cycle 1/1 for v8_7 test... 01:48:16 INFO - 2015-12-03 01:48:16,318 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaByA1W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:48:28 INFO - 2015-12-03 01:48:28,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 143798272 01:48:28 INFO - 2015-12-03 01:48:28,376 DEBUG : BROWSER_OUTPUT: 01:48:49 INFO - 2015-12-03 01:48:49,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:37065/tests/v8_7/run.html (next: http://localhost:37065/tests/v8_7/run.html) 01:48:50 INFO - 2015-12-03 01:48:50,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 461303808 01:48:50 INFO - 2015-12-03 01:48:50,078 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,078 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:48:50 INFO - 2015-12-03 01:48:50,078 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:48:50 INFO - 2015-12-03 01:48:50,078 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:48:50 INFO - 2015-12-03 01:48:50,078 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:48:50 INFO - 2015-12-03 01:48:50,078 DEBUG : BROWSER_OUTPUT: |0;Richards;165.01650165016503 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.8770567572564 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 01:48:50 INFO - 2015-12-03 01:48:50,079 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 01:48:50 INFO - 2015-12-03 01:48:50,080 DEBUG : BROWSER_OUTPUT: |8;Splay;613.4969325153374 01:48:50 INFO - 2015-12-03 01:48:50,080 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 01:48:50 INFO - 2015-12-03 01:48:50,080 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:48:50 INFO - 2015-12-03 01:48:50,080 DEBUG : BROWSER_OUTPUT: __startTimestamp1449136130075__endTimestamp 01:48:50 INFO - 2015-12-03 01:48:50,080 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,080 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:48:50 INFO - 2015-12-03 01:48:50,081 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:48:50 INFO - 2015-12-03 01:48:50,081 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,081 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,081 DEBUG : BROWSER_OUTPUT: Values: 165.0 01:48:50 INFO - 2015-12-03 01:48:50,081 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.88 Median:184.88 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: Values: 184.9 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: Values: 277.9 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,083 DEBUG : BROWSER_OUTPUT: Values: 5202.1 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: Values: 1978.3 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: Values: 794.3 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: Values: 12132.5 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: Values: 26025.6 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.50 Median:613.50 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: Values: 613.5 01:48:50 INFO - 2015-12-03 01:48:50,084 DEBUG : BROWSER_OUTPUT: 01:48:50 INFO - 2015-12-03 01:48:50,085 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 01:48:50 INFO - 2015-12-03 01:48:50,085 DEBUG : BROWSER_OUTPUT: Values: 4835.7 01:48:50 INFO - 2015-12-03 01:48:50,085 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:48:50 INFO - 2015-12-03 01:48:50,085 DEBUG : BROWSER_OUTPUT: 01:48:51 INFO - 2015-12-03 01:48:51,064 INFO : Browser exited with error code: 0 01:48:51 INFO - 2015-12-03 01:48:51,081 INFO : Completed test v8_7 (00:00:40) 01:48:51 INFO - 2015-12-03 01:48:51,560 INFO : Completed test suite (00:20:19) 01:48:51 INFO - 2015-12-03 01:48:51,560 DEBUG : Working with test: dromaeo_css 01:48:51 INFO - 2015-12-03 01:48:51,560 DEBUG : Generating results file: dromaeo_css 01:48:51 INFO - 2015-12-03 01:48:51,561 DEBUG : Working with test: kraken 01:48:51 INFO - 2015-12-03 01:48:51,561 DEBUG : Generating results file: kraken 01:48:51 INFO - 2015-12-03 01:48:51,562 INFO : javascript benchmark 01:48:51 INFO - 2015-12-03 01:48:51,562 DEBUG : Working with test: v8_7 01:48:51 INFO - 2015-12-03 01:48:51,562 DEBUG : Generating results file: v8_7 01:48:51 INFO - 2015-12-03 01:48:51,562 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:48:51 INFO - 2015-12-03 01:48:51,617 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 01:48:51 INFO - 2015-12-03 01:48:51,617 DEBUG : process_Request line: dromaeo_css 6386.68 graph.html#tests=[[72,132,35]] 01:48:51 INFO - 2015-12-03 01:48:51,617 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:48:51 INFO - 2015-12-03 01:48:51,655 DEBUG : process_Request line: kraken 1522.70 graph.html#tests=[[232,132,35]] 01:48:51 INFO - 2015-12-03 01:48:51,655 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:48:51 INFO - 2015-12-03 01:48:51,687 DEBUG : process_Request line: v8_7 19868.83 graph.html#tests=[[230,132,35]] 01:48:51 INFO - 2015-12-03 01:48:51,688 INFO : javascript benchmark 01:48:51 INFO - 2015-12-03 01:48:51,692 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2595.740425957404, 2673.064427450394, 2680.5845094010433, 2688.7580117789394, 2703.783697304216, 4518.728876267426, 4592.908141837162, 4663.65022623303, 4676.719396836188, 4702.388689470368, 4578.244589642713, 4601.286800545912, 4665.766711664412, 4690.343351930724, 4695.85912422627, 4300.096979634272, 4328.870133895973, 4337.392765012901, 4347.13057388522, 4406.867793966187, 4173.998240422307, 4407.2948328267485, 4411.360352748849, 4455.688101832873, 4462.352958820969, 4232.936505952413, 4282.550332215135, 4286.142771445723, 4311.094670119247, 4323.0, 4332.870013899588, 4357.694961352707, 4363.0, 4381.342798580206, 4402.031553058322, 4360.934585981213, 4362.040351122748, 4363.912721745547, 4374.365716971021, 4418.469783625986, 4375.059362237134, 4493.505714371417, 4499.550044995474, 4526.117407105616, 4615.053913947632, 5011.2483127530795, 5045.369328833895, 5049.671771334852, 5054.267131265946, 5097.7960881564695, 5069.290299358093, 5069.670471419346, 5074.3657042869645, 5074.5432911037815, 5116.846494605168, 4557.977210113928, 4655.255159174583, 4681.648876334289, 4682.0, 4782.784774685148, 5156.664816786897, 5181.404138524118, 5194.532492075731, 5197.350331208599, 5248.580113590903, 4965.528274813887, 4979.178435558165, 4979.925301120486, 4981.352424184905, 5040.7731652075745, 4769.379980602499, 4890.266460031024, 4893.975530122327, 4929.014197160511, 5008.949910500921, 4988.0, 4994.800207991712, 4995.375578052744, 5004.049230646238, 5026.120428924996, 4941.209406494943, 4946.035523073038, 4950.430700469492, 4955.281484184773, 4994.051130285234, 3986.3422535281934, 4051.331530297527, 4093.774842383638, 4169.854055108057, 4212.136512015029, 3590.425531914881, 3628.2380700053286, 3635.4910312556262, 3652.945205821915, 3684.926301474009, 4324.1567894260315, 4411.536788637147, 4413.713108647928, 4422.513523512411, 4471.888202794956, 4910.508949105132, 5035.79856805731, 5042.3444952156715, 5132.8460146195675, 5149.150390185652, 4231.40760293553, 4319.460067491564, 4321.978390108029, 4340.76125813077, 4341.652667786632, 4492.550744925481, 4517.6160026397465, 4518.480374756879, 4518.977405113019, 4565.338025986213, 4867.537583929521, 4869.4400143982475, 4875.390576177978, 4879.4876537963, 4920.261960705922, 4752.9049419010735, 4863.805447782049, 4869.147899117711, 4952.5542701157065, 5065.164247899055, 4835.395575553056, 4860.756962151808, 4869.610431165427, 4870.853874383774, 4871.439784424837, 5018.328153637676, 5032.899342013213, 5037.672551284155, 5038.596912247085, 5086.160783470686, 4879.707217566957, 4996.6002719783055, 4998.775055122601, 5083.339165908408, 5101.056304583664, 4783.402074740658, 4859.635527335535, 4863.562279394871, 4865.781039853286, 4903.705777653352, 4842.0, 4865.0999565079155, 4888.095702295087, 4891.119598472309, 4901.705897646153, 4610.585047345755, 4691.390119284471, 4702.717836929795, 4780.641451891052, 4820.662553621213, 4791.161546729378, 4949.529794669501, 4974.502549745142, 4982.676126051795, 4996.875078123076, 4834.5890599298045, 4845.53967373099, 4856.885563178834, 4857.101436234308, 4895.975520122377], "unit": "ms", "name": "dojo.html", "value": 4606.51127542644}, {"lowerIsBetter": false, "replicates": [557.2811073714905, 558.1627558662004, 590.4449817171861, 591.7130191856949, 600.3996003996004, 28269.434611307763, 37221.44167837481, 37588.62411375885, 37772.0, 37841.62158378415, 40351.0, 40832.387514187234, 40832.79583602078, 40852.795736021355, 40891.0, 7070.469714771387, 7183.461240406964, 7987.640556174957, 8142.389320800934, 8163.95918020409, 10167.983201679846, 10529.15766738663, 10534.841977370346, 10537.47312634369, 10538.420386878719, 10097.444640544767, 10207.591696332138, 10209.642662506814, 10215.131713804336, 10223.846642300372, 7319.5242309249725, 7487.0, 7488.5506869588, 7509.286617771303, 10184.0, 10346.896531034668, 10589.205809564313, 10635.840462393071, 10639.734006649818, 10642.361458312525, 37152.44271335932, 37500.812495937345, 37536.24927501435, 37574.43638345427, 37629.0, 2862.084133077416, 2900.5214139666928, 2933.296008957856, 3000.429918315513, 3425.400554902882, 28077.71922280792, 28337.57493637597, 28472.0, 28531.0, 29176.854115729497, 3039.149038269288, 3054.312779624589, 3059.5104783234797, 3124.2345625321714, 3143.6070491188602, 212668.0, 212723.0, 212745.0, 213680.0, 213744.0, 50159.24761128586, 50817.237741433906, 53362.46637533575, 54196.45803541993, 54269.72865135649, 54582.45417545853, 54659.72670136624, 54963.175552366745, 54980.0, 54996.0, 14054.508092216724, 14253.216073116078, 14256.073355232083, 14261.78607320891, 14269.357878895475, 10628.627998020032, 10733.0, 10736.409497477558, 10817.350958942488, 10859.0, 17647.205875735624, 17978.91010544965, 18048.0, 18066.3676771315, 18131.18409671568, 7231.3130252625915, 7529.924700753032, 7572.8485430292185, 7603.0876294844975, 7608.087029556488, 840.8192238668715, 844.4173520271116, 856.2892798976834, 864.6109250837022, 915.1946287267295, 23339.649905251434, 23812.523749524913, 24610.0, 24671.50656986886, 24759.3810154744, 955.9665411710696, 1004.0612027754073, 1023.0383439566783, 1040.2406243442329, 1064.6007747094839, 13141.802872956914, 14007.229602371968, 14523.491677791226, 14726.779098313535, 14817.555473335817, 266205.0, 272347.0, 272799.0, 273056.0, 273701.0, 45812.54187458083, 46006.07987840224, 46166.30750538745, 46183.30725039127, 46184.76907615441, 1081.8269076947809, 1246.526319998395, 1250.9061820363509, 1253.3482589053824, 1266.1453518874723, 19667.508312292306, 26495.867520662272, 26977.730222697523, 29021.12936611905, 29460.705392946653, 40754.0, 41230.38154427626, 41315.38026929538, 41315.7934210327, 41327.58672413237, 213156.0, 213603.0, 222957.0, 226168.0, 239669.0, 26531.86734066317, 26843.19470415891, 26863.86568067147, 27245.0, 27309.453810924068, 35038.29923401467, 38435.6156438432, 39508.40737388999, 39534.604653953094, 40450.0, 31556.36887262288, 33454.83272583621, 33473.163170920925, 36358.636413635526, 36439.63560364363, 31885.840570796998, 32163.35673286568, 32216.0, 32694.509582355808, 32776.67223327832, 32823.19472428944, 32870.0, 33058.0, 33340.666593334725, 33455.83272083624, 27294.317642059108, 28883.5667464984, 29475.74581191187, 29610.259743506584, 29901.0, 22819.475147081015, 23040.0, 23470.64794028125, 23523.882380587987, 23623.40941476477], "unit": "ms", "name": "ext.html", "value": 17040.832518936495}, {"lowerIsBetter": false, "replicates": [334.67034970554016, 338.9084947064293, 340.14453649072584, 340.23447243701673, 340.81255309579734, 11945.701357466047, 12354.752904941895, 14978.625534361632, 15059.17174555399, 15844.049357038572, 12897.484100635964, 14985.400583976656, 15004.699906001873, 15263.389464421438, 15355.232238388091, 4093.9795301023455, 4924.926126108102, 5047.0915235257635, 5096.133657278253, 5113.488651134894, 5026.447090820006, 5032.094223039851, 5041.72270525121, 5046.21783623539, 5052.545270925634, 4996.575291100261, 5000.624953128512, 5003.899922001558, 6430.7749228777, 6734.090897728817, 6583.868322633544, 6611.338866113399, 6613.437857782094, 6620.073189753391, 6620.238672552646, 6251.78118765841, 6503.804885853432, 6504.38208370204, 6505.512086593524, 6507.414332710079, 15476.148811815345, 15621.609459763484, 17201.311947522085, 17876.28494860204, 19427.4171774847, 2044.8568600197991, 2084.833213342929, 2093.6336141175384, 2109.4304537774715, 2174.6737989301573, 13320.733585328337, 13664.0, 13927.948577407882, 13992.020558560906, 14098.647533811736, 1881.1816859665953, 1882.8023057578894, 1889.527618095476, 1917.8657493975427, 1973.4572992427197, 60475.39524604742, 64799.67600162016, 64831.0, 65114.674426627564, 65594.0, 14776.527516033724, 15586.844131558539, 15662.451814186448, 15675.843241567667, 15676.529704108894, 18669.719954200697, 19244.23023079089, 22185.778142218693, 23895.761042389702, 23916.641250381257, 8066.717664881701, 8219.589020549069, 8333.541655209021, 8378.329733621296, 8384.203500667549, 6863.416609588141, 6873.312668733087, 6884.759033433906, 6927.0, 6949.548279361826, 7566.886496702554, 7577.924220757832, 7592.772216833504, 7611.238876112455, 7655.157932627407, 2929.0, 2953.6898625644426, 3013.608230929965, 3049.344390955955, 3056.1290032340676, 786.5673879366326, 831.2477208126655, 840.5755093677653, 904.9592768325441, 957.2437774158476, 15486.690266194839, 15899.364025438854, 16261.0, 16423.343066277215, 16522.75215871763, 835.9038710548243, 837.3134030095385, 863.0851297624538, 900.8828852249165, 959.6737109382843, 7229.638518074075, 8637.179467950535, 9264.44413335202, 9294.256459483226, 9532.714018579454, 319676.0, 319805.0, 320910.0, 321150.0, 321263.0, 62334.0, 66427.0, 72757.63621181861, 72807.63596182091, 73569.26430735731, 1013.7516308504464, 1049.9632512862165, 1055.0188324857957, 1058.5977328615077, 1080.708208783624, 13424.93287533556, 13578.592642220749, 13671.248081355621, 13751.656208594864, 13989.440422383397, 28554.714452856035, 29107.708922911348, 29674.258143546584, 29677.554836677034, 29782.25544361408, 37951.62048379481, 39834.40248396334, 39880.60119398769, 41291.0, 42562.78718606387, 8213.95893020531, 8307.252347288773, 8536.91463085386, 8561.828763424572, 8696.91303086961, 9933.602655893972, 9935.552900119368, 9983.15143212835, 9985.1512621428, 12416.441260143496, 12422.503099875903, 12532.436040378387, 13115.737685246051, 14076.718465630425, 14158.716825663223, 12841.29372884463, 13358.532451364155, 13361.66595835073, 13513.0, 13690.452381904612, 13275.544024355526, 13551.777925703544, 13610.0, 13944.4422223114, 14618.0, 8429.11494293115, 8629.482231066157, 8644.135586441305, 8765.07966663491, 8781.25359344463, 9153.130452606993, 9224.631014759334, 13151.671208219872, 13982.860171398563, 14118.364673589918], "unit": "ms", "name": "jquery.html", "value": 8798.774910448194}, {"lowerIsBetter": false, "replicates": [1233.7285797124641, 1424.8361438434579, 1482.4737218287507, 1590.2048975512243, 1741.1903464888833, 6039.275286965565, 6957.234704182536, 7084.326988936049, 7094.538854974436, 7094.929050709491, 7058.470614703892, 7318.414526837853, 7325.047743793312, 7325.853482930338, 7325.963370183155, 2028.9086991085362, 2079.9480012999643, 2080.750309962799, 2080.927167549136, 2081.42760740796, 2076.470500022492, 2098.6012657595084, 2101.338078505266, 2121.63932131538, 2128.17001369466, 2063.865848719836, 2104.3489545638304, 2106.6208082545136, 2137.732783402075, 2139.283340081067, 2029.1376165129761, 2066.3077868913933, 2081.9791802081936, 2084.4267826347723, 2084.7178984924312, 2035.9287424940205, 2077.968830467544, 2079.4905248214286, 2080.0847627044054, 2086.6557018092, 6045.274567051938, 6279.058141278845, 7155.212926578072, 7274.236205198484, 7282.563046217191, 3967.6825853931905, 4095.201435720036, 4106.938395924063, 4115.52671442785, 4117.5882411758885, 2629.5661215899354, 2646.93382665433, 2660.361513236809, 2687.314734742628, 2692.67687877454, 825.8059356051323, 839.4543546694697, 845.3744229270358, 847.8728190771373, 848.2916764501648, 9411.152996230303, 9504.144626983605, 9522.571484283155, 9525.761855953588, 9545.665901693477, 3847.9807600962376, 3848.518320446592, 3900.0, 3903.921921561553, 3908.022994251437, 8231.835363292821, 8239.464434811838, 8254.54599996994, 8286.378521610903, 8298.958505207556, 4140.171965606891, 4191.308434108338, 4204.579542045771, 4205.558416366299, 4215.262329092458, 3836.462895194675, 3844.0, 3845.3655146900446, 3848.037990502374, 3852.3451013327804, 3250.9837450812593, 3253.3168034712503, 3280.8851690190727, 3283.83580820958, 3290.341931613639, 1052.9631462898762, 1053.378506681062, 1054.7132498352153, 1056.2131212246773, 1057.2652006855162, 1198.4726720243066, 1205.81912713092, 1208.522633559739, 1228.0728050322127, 1230.698478872682, 6745.325467453215, 6814.591124532544, 6843.931560684429, 6852.177738671391, 6864.897026544606, 389.42170876248747, 392.162732565968, 394.7236934146109, 395.1523981060609, 414.819553494231, 4974.452810190948, 5330.680159190461, 5394.136938089887, 5409.783608655688, 5412.756425960842, 7560.848783024308, 8076.111627720946, 8283.710070147516, 8292.253697167283, 8303.377246706521, 8225.424220304521, 8234.300084492885, 8260.958695206486, 8324.833503329899, 8327.95836020816, 6347.777827776005, 6576.1122248496795, 6580.86838263232, 6602.603843769293, 6650.733970641217, 6681.46548276127, 6716.865662686621, 6734.73061077571, 6772.55978361405, 6788.287229840796, 7232.855342893007, 7453.031105956191, 7455.0681164854395, 7543.245675432413, 7564.962175189309, 7679.462437629312, 7885.369170466234, 7904.84190316202, 7931.801704957422, 8016.83966320682, 6278.0, 6286.685665716787, 6328.778492752732, 6339.809805705836, 6354.555181137276, 6676.098726672031, 6711.731530738911, 6747.527673063035, 6793.150856142982, 6818.488613354118, 6397.584157029778, 6484.967575162094, 6500.057491663588, 6568.244651865097, 6584.407403333723, 6337.90493142594, 6436.13112229843, 6488.70800813974, 6493.805185844432, 6540.117084193573, 6562.507811914221, 6581.703823327866, 6635.8009259722285, 6638.900416493853, 6652.434543063894, 5705.372409035086, 5817.243758311392, 5818.4763371296785, 6034.607750496204, 6089.786857459968, 6002.969985150046, 6045.818625441244, 6048.183495228088, 6063.575549711654, 6065.636061836304], "unit": "ms", "name": "mootools.html", "value": 3981.3215645858563}, {"lowerIsBetter": false, "replicates": [293.24343194558037, 301.1252312033542, 303.0877060049251, 305.2627903612774, 306.0573433823822, 5254.7635356408955, 5306.336707911511, 5373.113436283018, 5405.540529055035, 5424.566034717223, 5287.894242115165, 5298.867528311785, 5314.734263286829, 5325.920111198326, 5334.626576139672, 3909.9609003910023, 4166.208420400129, 4171.749695018293, 4174.248635245654, 4178.080822219107, 4009.719319647626, 4048.251073551388, 4136.772477513736, 4167.520735115455, 4187.057911969798, 4107.650849677781, 4114.567970363114, 4120.093579412524, 4140.0891803803115, 4140.23405669952, 3891.377379619247, 3971.702122340807, 4017.4174744662155, 4123.773192474413, 4125.4843144607075, 3606.9819650901577, 3630.16506203572, 3635.6909662678704, 3641.799701016443, 3644.3804553226014, 5102.285680004802, 5105.897882042338, 5108.055009823194, 5117.897642047138, 5119.078565858144, 4745.264484004951, 4747.643926705477, 4750.667453278272, 4751.31105989633, 4761.26200438929, 5436.786490469917, 5582.190582365575, 5586.441355864422, 5590.5527557795685, 5599.104143337087, 3952.7628342299554, 3954.62431069048, 3958.5645578986287, 3959.208158368338, 3959.544652364986, 5874.060150375919, 5893.351731309553, 5894.17481552583, 5895.4399332063385, 5896.321922978869, 4087.2847251730827, 4093.7543747375253, 4094.672426205956, 4094.8566800161852, 4096.1193343431305, 3692.649198326155, 3878.553966293856, 4159.83360665576, 4160.9805597628165, 4165.8541951032175, 4452.265376212953, 4539.228331183706, 4574.4968053514085, 4601.539846015372, 4689.62483001359, 5561.5272701820795, 5592.217089607459, 5593.133064375028, 5597.720113994284, 5598.1602759586385, 1410.3935307817737, 1432.9713405731827, 1433.9498117566043, 1434.103685196752, 1436.0737324425686, 953.5661274120258, 958.2094771813282, 961.7595601099725, 979.8285300072458, 980.4019548075668, 4938.777755001033, 4943.9258411123865, 4949.628777841676, 4953.43035550909, 4959.429665588431, 5820.35976042635, 5820.70896455184, 5826.737796799154, 5829.562782791223, 5838.511179649162, 4882.804687812519, 4916.164252077156, 4927.260910863399, 4930.556249937523, 4932.334134891816, 3057.480228361184, 3095.7059079387423, 3124.765642576816, 3127.640321363027, 3136.780425370202, 5583.134614134816, 5586.832395028156, 5591.4688104629995, 5597.524210442158, 5598.86002849932, 6013.338532761392, 6022.939770602326, 6037.215162028908, 6045.879082418415, 6047.395260473917, 5598.944010559842, 5600.159976003632, 5601.075822489243, 5604.467575580314, 5606.55147588192, 5819.82540523785, 5858.384869588632, 5867.383924687846, 5876.412358764261, 5877.500412464818, 5721.971390143022, 5722.484976352148, 5731.914021289601, 5734.569907256889, 5737.56968227393, 5557.138643510262, 5586.273784408001, 5586.636868603528, 5594.468525490072, 5597.384287728265, 3884.18432129256, 3950.3481925483125, 3989.640932315989, 3998.7800670963375, 3999.7600143991453, 5762.135679648086, 5833.562482813891, 5845.590808643524, 5854.970725146347, 5858.8242352729485, 5610.691411972381, 5615.7192140392, 5618.943810561842, 5622.100463925753, 5628.63413878113, 5497.423859635137, 5604.075327570905, 5608.943910560843, 5611.663300202001, 5617.32592088952, 5431.456854314537, 5471.124620060771, 5478.780848766005, 5488.890222195454, 5489.149181876815, 5462.0, 5611.270534830446, 5652.547796176378, 5653.180288858175, 5660.7169641518585, 5406.459354064562, 5525.281713377235, 5527.806526771544, 5540.279763630702, 5548.667079975215], "unit": "ms", "name": "prototype.html", "value": 4213.671523757309}, {"lowerIsBetter": false, "replicates": [770.9653065612047, 778.6768491076203, 791.3589992106395, 808.7088648086687, 831.8918540589723, 12297.938510307447, 12570.685732856671, 12615.05387095967, 12632.178908370972, 12662.176958497692, 13460.46158153675, 13536.0, 13553.52562660307, 13561.93219033906, 13566.728665426686, 628.1896353703717, 636.6021236727046, 819.8729196974479, 834.1825011488745, 834.9624266908004, 803.7307501986842, 811.809224832164, 819.1235378145357, 820.1142765812908, 820.1142765812908, 854.2567965869702, 862.0216054777841, 862.2196911794805, 862.3661608717588, 862.5514732339179, 654.3162395296903, 662.7216569041015, 845.5349557743217, 849.0914721248267, 862.6592495964122, 634.3244444666416, 636.7930422612623, 638.2373064188297, 638.3807706524664, 638.4094712391067, 11910.880891191064, 12099.87900121005, 12119.697007574881, 12129.150959432844, 12135.817962730478, 11036.392998385085, 11086.667399977932, 11296.435178241138, 11380.089592832637, 11772.99929505993, 9342.252619790468, 9558.90441095594, 9575.138237558653, 9761.267904907088, 9771.316007879452, 3119.173419043955, 3173.0480855743417, 3186.522021696741, 3214.100051985448, 3218.163277547831, 41119.588804111874, 41416.0, 41570.58429415728, 41587.37618935719, 41689.1662166755, 9079.455232685928, 9262.444253344685, 9302.395344302735, 9343.159115679622, 9367.906320936703, 16171.353145874033, 16213.189340532927, 16232.75650865238, 16242.51272461828, 16250.918745406198, 6277.811665650038, 6294.0, 6348.269948955837, 6354.110424540568, 6543.083968244449, 3637.745357824927, 3641.9453708194396, 3682.760620559655, 3727.6645101940953, 3739.0652336915773, 2747.189579074178, 2794.9720502795117, 2803.355228297503, 2808.845513496777, 3001.9249518762203, 548.3282978351488, 549.2996429552273, 561.4217356123199, 563.3352643880261, 568.1619611073634, 477.79216041021573, 556.326849488205, 616.2050954269032, 618.1284389011472, 630.0895206426761, 7510.774676759596, 7568.053993250844, 7644.961775191088, 7813.296803287732, 7869.803254918558, 488.30904270456904, 556.8524341049625, 582.1093726598311, 582.7406803972276, 590.4420322794917, 3539.50446937429, 3568.57177138745, 3772.9434058489146, 3800.657940785343, 3837.501124853751, 49080.26379604309, 49970.75014624903, 50079.749601252486, 54578.18132728012, 54919.0, 44703.32945005828, 45001.0, 45745.0, 45882.0, 46428.0, 42115.0, 42362.788186058875, 42628.57371426308, 43224.351634725506, 43376.3493547597, 7589.354904833151, 8195.95902020486, 8243.197312913639, 8322.875156872773, 8368.7907802303, 31655.84172079125, 32222.0, 32558.34883302368, 32946.5058024125, 33008.53410391874, 37661.435078474395, 41770.0, 41986.58013419949, 42143.0, 42219.36670949877, 9956.601735930482, 9983.60065597368, 10014.899851001397, 10060.597576096874, 10064.295499314978, 10564.788704226026, 10604.681859544226, 11043.337399756041, 11463.31220126795, 11542.076633869103, 10745.0, 11362.943185284352, 11488.712782180512, 11747.47136378848, 11901.464434100313, 9084.227840633355, 9488.525573721425, 10650.201234907257, 10938.12495000414, 11138.498767555642, 9674.95162524211, 10721.678349649523, 11323.0, 11402.372869491926, 11580.594679186188, 9051.59267832936, 9115.453072815651, 9271.490068046322, 9273.67542136022, 9525.571349289437, 8755.299576034029, 9525.857112143185, 9592.616295348107, 9609.039096090335, 9720.708378748648], "unit": "ms", "name": "yui.html", "value": 5856.423279246284}], "name": "dromaeo_css", "value": 6386.684956636359}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 110.0, 109.0, 110.0, 100.0, 110.0, 110.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 107.8}, {"lowerIsBetter": true, "replicates": [162.0, 148.0, 164.0, 168.0, 146.0, 153.0, 161.0, 131.0, 173.0, 135.0], "unit": "ms", "name": "audio-beat-detection", "value": 154.1}, {"lowerIsBetter": true, "replicates": [163.0, 160.0, 161.0, 159.0, 160.0, 159.0, 161.0, 160.0, 160.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 93.0, 90.0, 70.0, 72.0, 71.0, 118.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 94.0, 95.0, 94.0, 132.0, 95.0, 94.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 72.0, 71.0, 70.0, 80.0, 68.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.1}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 83.0, 82.0, 85.0, 82.0, 84.0, 84.0, 83.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 127.0, 119.0, 122.0, 126.0, 129.0, 128.0, 127.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [149.0, 142.0, 154.0, 149.0, 139.0, 139.0, 154.0, 146.0, 144.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 72.0, 70.0, 70.0, 71.0, 70.0, 71.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1522.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "Richards", "value": 213.9301200000001}, {"lowerIsBetter": false, "replicates": [184.8770567572564], "unit": "score", "name": "DeltaBlue", "value": 357.63226199999986}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26025.641025641027], "unit": "score", "name": "RegExp", "value": 35.003364532019674}, {"lowerIsBetter": false, "replicates": [613.4969325153374], "unit": "score", "name": "Splay", "value": 132.83032999999998}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19868.826953053915}]} 01:48:51 INFO - RETURN: dromaeo_css: 6386.68 01:48:51 INFO - RETURN: kraken: 1522.70 01:48:51 INFO - RETURN: v8_7: 19868.83 01:48:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19868.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6386.68"}}} 01:48:51 INFO - Return code: 0 01:48:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:48:51 INFO - # TBPL SUCCESS # 01:48:51 INFO - Running post-action listener: _resource_record_post_action 01:48:51 INFO - Running post-run listener: _resource_record_post_run 01:48:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506531840; Read time: 8; Write time: 524044 01:48:52 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231747584; Read time: 0; Write time: 368828 01:48:52 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274227200; Read time: 8; Write time: 155216 01:48:52 INFO - Running post-run listener: _upload_blobber_files 01:48:52 INFO - Blob upload gear active. 01:48:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:48:52 INFO - Copying logs to upload dir... 01:48:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.810508 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-03 01:48:52.497406) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 01:48:52.501438) ========= 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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/LyCNorK9SBueuTbFU1lNyA/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-03 01:48:52.552476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:48:52.552839) ========= 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=c402a24d74c70935940d60dd000001de-1449134859.162939-1877271716 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004787 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 01:48:52.602930) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 01:48:52.603284) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 01:48:52.603579) ========= ========= Total master_lag: 0.22 =========