builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1449855894.7 results: success (0) buildid: 20151211083734 builduid: 0f5fa13365ea476496ab367f913f30d2 revision: 68963ed12683861d6ba5cdc29bdc83124c5577c7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.699018) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.699455) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.700037) ========= 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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005871 basedir: '/builds/slave/test' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.786584) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.786882) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.869368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.869702) ========= 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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.933146) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.933452) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.933798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:54.934089) ========= 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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 09:44:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-12-11 09:44:55 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163370 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.126778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.127137) ========= 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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020315 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.202567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.202894) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 68963ed12683861d6ba5cdc29bdc83124c5577c7 --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 68963ed12683861d6ba5cdc29bdc83124c5577c7 --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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 09:44:55,536 truncating revision to first 12 chars 2015-12-11 09:44:55,536 Setting DEBUG logging. 2015-12-11 09:44:55,536 attempt 1/10 2015-12-11 09:44:55,536 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/68963ed12683?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 09:44:55,810 unpacking tar archive at: fx-team-68963ed12683/testing/mozharness/ program finished with exit code 0 elapsedTime=0.531219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.754152) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.754533) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.765958) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.766249) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 09:44:55.766644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-11 09:44:55.766925) ========= /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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:44:56 INFO - MultiFileLogger online at 20151211 09:44:56 in /builds/slave/test 09:44:56 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 09:44:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:44:56 INFO - {'append_to_log': False, 09:44:56 INFO - 'base_work_dir': '/builds/slave/test', 09:44:56 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:44:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:44:56 INFO - 'branch': 'Fx-Team-Non-PGO', 09:44:56 INFO - 'buildbot_json_path': 'buildprops.json', 09:44:56 INFO - 'config_files': ('talos/linux_config.py',), 09:44:56 INFO - 'default_actions': ('clobber', 09:44:56 INFO - 'read-buildbot-config', 09:44:56 INFO - 'download-and-extract', 09:44:56 INFO - 'populate-webroot', 09:44:56 INFO - 'create-virtualenv', 09:44:56 INFO - 'install', 09:44:56 INFO - 'run-tests'), 09:44:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:44:56 INFO - 'download_minidump_stackwalk': True, 09:44:56 INFO - 'download_symbols': 'ondemand', 09:44:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:44:56 INFO - 'tooltool.py': '/tools/tooltool.py', 09:44:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:44:56 INFO - '/tools/misc-python/virtualenv.py')}, 09:44:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:44:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:44:56 INFO - 'installer_path': 'installer.exe', 09:44:56 INFO - 'log_level': 'info', 09:44:56 INFO - 'log_name': 'talos', 09:44:56 INFO - 'log_to_console': True, 09:44:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:44:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:44:56 INFO - 'opt_config_files': (), 09:44:56 INFO - 'pip_index': False, 09:44:56 INFO - 'sps_profile': False, 09:44:56 INFO - 'sps_profile_interval': 0, 09:44:56 INFO - 'suite': 'dromaeojs', 09:44:56 INFO - 'system_bits': '64', 09:44:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:44:56 INFO - 'title': 'talos-linux64-ix-003', 09:44:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:44:56 INFO - 'use_talos_json': True, 09:44:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:44:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:44:56 INFO - 'work_dir': 'build'} 09:44:56 INFO - ##### 09:44:56 INFO - ##### Running clobber step. 09:44:56 INFO - ##### 09:44:56 INFO - Running pre-action listener: _resource_record_pre_action 09:44:56 INFO - Running main action method: clobber 09:44:56 INFO - rmtree: /builds/slave/test/build 09:44:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:44:56 INFO - Running post-action listener: _resource_record_post_action 09:44:56 INFO - ##### 09:44:56 INFO - ##### Running read-buildbot-config step. 09:44:56 INFO - ##### 09:44:56 INFO - Running pre-action listener: _resource_record_pre_action 09:44:56 INFO - Running main action method: read_buildbot_config 09:44:56 INFO - Using buildbot properties: 09:44:56 INFO - { 09:44:56 INFO - "properties": { 09:44:56 INFO - "buildnumber": 1005, 09:44:56 INFO - "product": "firefox", 09:44:56 INFO - "script_repo_revision": "production", 09:44:56 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:44:56 INFO - "repository": "", 09:44:56 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:44:56 INFO - "buildid": "20151211083734", 09:44:56 INFO - "slavename": "talos-linux64-ix-003", 09:44:56 INFO - "pgo_build": "False", 09:44:56 INFO - "basedir": "/builds/slave/test", 09:44:56 INFO - "project": "", 09:44:56 INFO - "platform": "ubuntu64_hw", 09:44:56 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:44:56 INFO - "slavebuilddir": "test", 09:44:56 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:44:56 INFO - "branch": "fx-team", 09:44:56 INFO - "repo_path": "integration/fx-team", 09:44:56 INFO - "stage_platform": "linux64", 09:44:56 INFO - "builduid": "0f5fa13365ea476496ab367f913f30d2", 09:44:56 INFO - "revision": "68963ed12683861d6ba5cdc29bdc83124c5577c7" 09:44:56 INFO - }, 09:44:56 INFO - "sourcestamp": { 09:44:56 INFO - "repository": "", 09:44:56 INFO - "hasPatch": false, 09:44:56 INFO - "project": "", 09:44:56 INFO - "branch": "fx-team-linux64-talos", 09:44:56 INFO - "changes": [ 09:44:56 INFO - { 09:44:56 INFO - "category": null, 09:44:56 INFO - "files": [ 09:44:56 INFO - { 09:44:56 INFO - "url": null, 09:44:56 INFO - "name": "https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:44:56 INFO - } 09:44:56 INFO - ], 09:44:56 INFO - "repository": "", 09:44:56 INFO - "rev": "68963ed12683861d6ba5cdc29bdc83124c5577c7", 09:44:56 INFO - "who": "dtownsend@mozilla.com", 09:44:56 INFO - "when": 1449855846, 09:44:56 INFO - "number": 7350230, 09:44:56 INFO - "comments": "Bug 1231867: Remove use of the spread operator to support node 4.2. r=miker", 09:44:56 INFO - "project": "", 09:44:56 INFO - "at": "Fri 11 Dec 2015 09:44:06", 09:44:56 INFO - "branch": "fx-team-linux64-talos", 09:44:56 INFO - "revlink": "", 09:44:56 INFO - "properties": [ 09:44:56 INFO - [ 09:44:56 INFO - "buildid", 09:44:56 INFO - "20151211083734", 09:44:56 INFO - "Change" 09:44:56 INFO - ], 09:44:56 INFO - [ 09:44:56 INFO - "builduid", 09:44:56 INFO - "0f5fa13365ea476496ab367f913f30d2", 09:44:56 INFO - "Change" 09:44:56 INFO - ], 09:44:56 INFO - [ 09:44:56 INFO - "pgo_build", 09:44:56 INFO - "False", 09:44:56 INFO - "Change" 09:44:56 INFO - ] 09:44:56 INFO - ], 09:44:56 INFO - "revision": "68963ed12683861d6ba5cdc29bdc83124c5577c7" 09:44:56 INFO - } 09:44:56 INFO - ], 09:44:56 INFO - "revision": "68963ed12683861d6ba5cdc29bdc83124c5577c7" 09:44:56 INFO - } 09:44:56 INFO - } 09:44:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:44:56 INFO - Running post-action listener: _resource_record_post_action 09:44:56 INFO - ##### 09:44:56 INFO - ##### Running download-and-extract step. 09:44:56 INFO - ##### 09:44:56 INFO - Running pre-action listener: _resource_record_pre_action 09:44:56 INFO - Running main action method: download_and_extract 09:44:56 INFO - mkdir: /builds/slave/test/build/tests 09:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:56 INFO - https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:44:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/test_packages.json 09:44:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/test_packages.json 09:44:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:44:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:44:58 INFO - Downloaded 1302 bytes. 09:44:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:44:58 INFO - Using the following test package requirements: 09:44:58 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:44:58 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:44:58 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'jsshell-linux-x86_64.zip'], 09:44:58 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:44:58 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:44:58 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:44:58 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:44:58 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:44:58 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:44:58 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:44:58 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:44:58 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:44:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:44:58 INFO - https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:44:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:44:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:44:59 INFO - Downloaded 21874385 bytes. 09:44:59 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 09:44:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:44:59 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 09:45:01 INFO - Return code: 0 09:45:01 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 09:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:01 INFO - https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:45:01 INFO - Downloaded 21874385 bytes. 09:45:01 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 09:45:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:45:01 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 09:45:03 INFO - Return code: 0 09:45:03 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')]} 09:45:03 INFO - https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:45:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:45:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:45:04 INFO - Downloaded 11132038 bytes. 09:45:04 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 09:45:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:45:04 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 09:45:04 INFO - Return code: 0 09:45:04 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')]} 09:45:04 INFO - https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:45:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:45:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:45:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:45:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/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 09:45:06 INFO - Downloaded 57729173 bytes. 09:45:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:45:06 INFO - mkdir: /builds/slave/test/properties 09:45:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:06 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:06 INFO - Contents: 09:45:06 INFO - build_url:https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:45:06 INFO - Running post-action listener: _resource_record_post_action 09:45:06 INFO - Running post-action listener: set_extra_try_arguments 09:45:06 INFO - ##### 09:45:06 INFO - ##### Running populate-webroot step. 09:45:06 INFO - ##### 09:45:06 INFO - Running pre-action listener: _resource_record_pre_action 09:45:06 INFO - Running main action method: populate_webroot 09:45:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:06 INFO - '--tppagecycles', 09:45:06 INFO - '7'], 09:45:06 INFO - 'tests': ['tsvgm']}}, 09:45:06 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:45:06 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:06 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:45:06 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:45:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'tests': ['damp', 'tps']}, 09:45:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['damp', 'tps']}, 09:45:06 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:45:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:06 INFO - 'other': {'tests': ['a11yr', 09:45:06 INFO - 'ts_paint', 09:45:06 INFO - 'tpaint', 09:45:06 INFO - 'sessionrestore', 09:45:06 INFO - 'sessionrestore_no_auto_restore']}, 09:45:06 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['a11yr', 09:45:06 INFO - 'ts_paint', 09:45:06 INFO - 'tpaint', 09:45:06 INFO - 'sessionrestore', 09:45:06 INFO - 'sessionrestore_no_auto_restore']}, 09:45:06 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['a11yr', 09:45:06 INFO - 'ts_paint', 09:45:06 INFO - 'tpaint', 09:45:06 INFO - 'sessionrestore', 09:45:06 INFO - 'sessionrestore_no_auto_restore']}, 09:45:06 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['a11yr', 09:45:06 INFO - 'ts_paint', 09:45:06 INFO - 'tpaint', 09:45:06 INFO - 'sessionrestore', 09:45:06 INFO - 'sessionrestore_no_auto_restore']}, 09:45:06 INFO - 'other_l64': {'tests': ['a11yr', 09:45:06 INFO - 'ts_paint', 09:45:06 INFO - 'tpaint', 09:45:06 INFO - 'sessionrestore', 09:45:06 INFO - 'sessionrestore_no_auto_restore']}, 09:45:06 INFO - 'other_nol64': {'tests': ['a11yr', 09:45:06 INFO - 'ts_paint', 09:45:06 INFO - 'tpaint', 09:45:06 INFO - 'sessionrestore', 09:45:06 INFO - 'sessionrestore_no_auto_restore']}, 09:45:06 INFO - 'svgr': {'tests': ['tsvgx', 09:45:06 INFO - 'tsvgr_opacity', 09:45:06 INFO - 'tart', 09:45:06 INFO - 'tscrollx', 09:45:06 INFO - 'cart']}, 09:45:06 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['tsvgx', 09:45:06 INFO - 'tsvgr_opacity', 09:45:06 INFO - 'tart', 09:45:06 INFO - 'tscrollx', 09:45:06 INFO - 'cart']}, 09:45:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'tests': ['tp5o']}, 09:45:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'talos_options': ['--e10s'], 09:45:06 INFO - 'tests': ['tp5o']}, 09:45:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'talos_options': ['--xperf_path', 09:45:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:06 INFO - 'tests': ['tp5n']}, 09:45:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:45:06 INFO - 'talos_options': ['--e10s', 09:45:06 INFO - '--xperf_path', 09:45:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:06 INFO - 'tests': ['tp5n']}}, 09:45:06 INFO - 'talos.zip': {'path': '', 09:45:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:06 INFO - Running post-action listener: _resource_record_post_action 09:45:06 INFO - ##### 09:45:06 INFO - ##### Running create-virtualenv step. 09:45:06 INFO - ##### 09:45:06 INFO - Running pre-action listener: _resource_record_pre_action 09:45:06 INFO - Running main action method: create_virtualenv 09:45:06 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:06 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 09:45:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:06 INFO - Using real prefix '/usr' 09:45:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:06 INFO - Installing distribute.............................................................................................................................................................................................done. 09:45:08 INFO - Installing pip.................done. 09:45:08 INFO - Return code: 0 09:45:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:45:08 INFO - Using env: {'DISPLAY': ':0', 09:45:08 INFO - 'HOME': '/home/cltbld', 09:45:08 INFO - 'LANG': 'en_US.UTF-8', 09:45:08 INFO - 'LANGUAGE': 'en_US:en', 09:45:08 INFO - 'LOGNAME': 'cltbld', 09:45:08 INFO - 'MAIL': '/var/mail/cltbld', 09:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:08 INFO - 'MOZ_NO_REMOTE': '1', 09:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:08 INFO - 'NO_EM_RESTART': '1', 09:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:08 INFO - 'PWD': '/builds/slave/test', 09:45:08 INFO - 'SHELL': '/bin/bash', 09:45:08 INFO - 'SHLVL': '1', 09:45:08 INFO - 'TERM': 'linux', 09:45:08 INFO - 'TMOUT': '86400', 09:45:08 INFO - 'USER': 'cltbld', 09:45:08 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:08 INFO - '_': '/tools/buildbot/bin/python'} 09:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:08 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 09:45:08 INFO - Cleaning up... 09:45:08 INFO - Return code: 0 09:45:08 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:45:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:45:08 INFO - Using env: {'DISPLAY': ':0', 09:45:08 INFO - 'HOME': '/home/cltbld', 09:45:08 INFO - 'LANG': 'en_US.UTF-8', 09:45:08 INFO - 'LANGUAGE': 'en_US:en', 09:45:08 INFO - 'LOGNAME': 'cltbld', 09:45:08 INFO - 'MAIL': '/var/mail/cltbld', 09:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:08 INFO - 'MOZ_NO_REMOTE': '1', 09:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:08 INFO - 'NO_EM_RESTART': '1', 09:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:08 INFO - 'PWD': '/builds/slave/test', 09:45:08 INFO - 'SHELL': '/bin/bash', 09:45:08 INFO - 'SHLVL': '1', 09:45:08 INFO - 'TERM': 'linux', 09:45:08 INFO - 'TMOUT': '86400', 09:45:08 INFO - 'USER': 'cltbld', 09:45:08 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:08 INFO - '_': '/tools/buildbot/bin/python'} 09:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:09 INFO - Downloading/unpacking psutil>=0.7.1 09:45:09 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 09:45:09 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 09:45:09 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 09:45:09 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 09:45:09 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 09:45:09 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 09:45:10 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:45:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:10 INFO - Installing collected packages: psutil 09:45:10 INFO - Running setup.py install for psutil 09:45:10 INFO - building 'psutil._psutil_linux' extension 09:45:10 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 09:45:11 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 09:45:11 INFO - building 'psutil._psutil_posix' extension 09:45:11 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 09:45:11 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 09:45:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:45:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:45:11 INFO - Successfully installed psutil 09:45:11 INFO - Cleaning up... 09:45:11 INFO - Return code: 0 09:45:11 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:11 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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:11 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 09:45:11 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 09:45:11 INFO - Using env: {'DISPLAY': ':0', 09:45:11 INFO - 'HOME': '/home/cltbld', 09:45:11 INFO - 'LANG': 'en_US.UTF-8', 09:45:11 INFO - 'LANGUAGE': 'en_US:en', 09:45:11 INFO - 'LOGNAME': 'cltbld', 09:45:11 INFO - 'MAIL': '/var/mail/cltbld', 09:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:11 INFO - 'MOZ_NO_REMOTE': '1', 09:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:11 INFO - 'NO_EM_RESTART': '1', 09:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:11 INFO - 'PWD': '/builds/slave/test', 09:45:11 INFO - 'SHELL': '/bin/bash', 09:45:11 INFO - 'SHLVL': '1', 09:45:11 INFO - 'TERM': 'linux', 09:45:11 INFO - 'TMOUT': '86400', 09:45:11 INFO - 'USER': 'cltbld', 09:45:11 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:11 INFO - '_': '/tools/buildbot/bin/python'} 09:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:11 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:45:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:45:13 INFO - Installing collected packages: mozsystemmonitor 09:45:13 INFO - Running setup.py install for mozsystemmonitor 09:45:13 INFO - Successfully installed mozsystemmonitor 09:45:13 INFO - Cleaning up... 09:45:13 INFO - Return code: 0 09:45:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:13 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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:13 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 09:45:13 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 09:45:13 INFO - Using env: {'DISPLAY': ':0', 09:45:13 INFO - 'HOME': '/home/cltbld', 09:45:13 INFO - 'LANG': 'en_US.UTF-8', 09:45:13 INFO - 'LANGUAGE': 'en_US:en', 09:45:13 INFO - 'LOGNAME': 'cltbld', 09:45:13 INFO - 'MAIL': '/var/mail/cltbld', 09:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:13 INFO - 'MOZ_NO_REMOTE': '1', 09:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:13 INFO - 'NO_EM_RESTART': '1', 09:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:13 INFO - 'PWD': '/builds/slave/test', 09:45:13 INFO - 'SHELL': '/bin/bash', 09:45:13 INFO - 'SHLVL': '1', 09:45:13 INFO - 'TERM': 'linux', 09:45:13 INFO - 'TMOUT': '86400', 09:45:13 INFO - 'USER': 'cltbld', 09:45:13 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:13 INFO - '_': '/tools/buildbot/bin/python'} 09:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:45:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:45:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:45:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45: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 09:45:16 INFO - Downloading docopt-0.6.1.tar.gz 09:45:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:45:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:45:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:45:16 INFO - Running setup.py install for blobuploader 09:45:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:45:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:45:16 INFO - Running setup.py install for requests 09:45:16 INFO - Running setup.py install for docopt 09:45:16 INFO - Successfully installed blobuploader requests docopt 09:45:16 INFO - Cleaning up... 09:45:16 INFO - Return code: 0 09:45:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:16 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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:16 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 09:45:16 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 09:45:16 INFO - Using env: {'DISPLAY': ':0', 09:45:16 INFO - 'HOME': '/home/cltbld', 09:45:16 INFO - 'LANG': 'en_US.UTF-8', 09:45:16 INFO - 'LANGUAGE': 'en_US:en', 09:45:16 INFO - 'LOGNAME': 'cltbld', 09:45:16 INFO - 'MAIL': '/var/mail/cltbld', 09:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:16 INFO - 'MOZ_NO_REMOTE': '1', 09:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:16 INFO - 'NO_EM_RESTART': '1', 09:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:16 INFO - 'PWD': '/builds/slave/test', 09:45:16 INFO - 'SHELL': '/bin/bash', 09:45:16 INFO - 'SHLVL': '1', 09:45:16 INFO - 'TERM': 'linux', 09:45:16 INFO - 'TMOUT': '86400', 09:45:16 INFO - 'USER': 'cltbld', 09:45:16 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:16 INFO - '_': '/tools/buildbot/bin/python'} 09:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:16 INFO - Running setup.py (path:/tmp/pip-vZOH9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:17 INFO - Running setup.py (path:/tmp/pip-oLUS27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:17 INFO - Running setup.py (path:/tmp/pip-40MNEQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:17 INFO - Running setup.py (path:/tmp/pip-nlYfbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:17 INFO - Running setup.py (path:/tmp/pip-48Lyki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:17 INFO - Running setup.py (path:/tmp/pip-4KVK6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:17 INFO - Running setup.py (path:/tmp/pip-VcwlzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:17 INFO - Running setup.py (path:/tmp/pip-bGebZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:17 INFO - Running setup.py (path:/tmp/pip-7_NjD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:17 INFO - Running setup.py (path:/tmp/pip-9qTX3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:17 INFO - Running setup.py (path:/tmp/pip-QraLMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:17 INFO - Running setup.py (path:/tmp/pip-dUIA1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:17 INFO - Running setup.py (path:/tmp/pip-SPvlfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:17 INFO - Running setup.py (path:/tmp/pip-KxegGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:17 INFO - Running setup.py (path:/tmp/pip-D7JwGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:18 INFO - Running setup.py (path:/tmp/pip-ZNZA2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:18 INFO - Running setup.py (path:/tmp/pip-QmTbf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:45:18 INFO - Running setup.py install for manifestparser 09:45:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Running setup.py install for mozcrash 09:45:18 INFO - Running setup.py install for mozdebug 09:45:18 INFO - Running setup.py install for mozdevice 09:45:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Running setup.py install for mozfile 09:45:18 INFO - Running setup.py install for mozhttpd 09:45:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Running setup.py install for mozinfo 09:45:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Running setup.py install for mozInstall 09:45:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:45:18 INFO - Running setup.py install for mozleak 09:45:19 INFO - Running setup.py install for mozlog 09:45:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Running setup.py install for moznetwork 09:45:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Running setup.py install for mozprocess 09:45:19 INFO - Running setup.py install for mozprofile 09:45:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Running setup.py install for mozrunner 09:45:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Running setup.py install for mozscreenshot 09:45:19 INFO - Running setup.py install for moztest 09:45:19 INFO - Running setup.py install for mozversion 09:45:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:45:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:45:19 INFO - Cleaning up... 09:45:19 INFO - Return code: 0 09:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:19 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 09:45:19 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 09:45:19 INFO - Using env: {'DISPLAY': ':0', 09:45:19 INFO - 'HOME': '/home/cltbld', 09:45:19 INFO - 'LANG': 'en_US.UTF-8', 09:45:19 INFO - 'LANGUAGE': 'en_US:en', 09:45:19 INFO - 'LOGNAME': 'cltbld', 09:45:19 INFO - 'MAIL': '/var/mail/cltbld', 09:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:19 INFO - 'MOZ_NO_REMOTE': '1', 09:45:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:19 INFO - 'NO_EM_RESTART': '1', 09:45:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:19 INFO - 'PWD': '/builds/slave/test', 09:45:19 INFO - 'SHELL': '/bin/bash', 09:45:19 INFO - 'SHLVL': '1', 09:45:19 INFO - 'TERM': 'linux', 09:45:19 INFO - 'TMOUT': '86400', 09:45:19 INFO - 'USER': 'cltbld', 09:45:19 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:19 INFO - '_': '/tools/buildbot/bin/python'} 09:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:45:20 INFO - Running setup.py (path:/tmp/pip-rGZNSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:45:20 INFO - Running setup.py (path:/tmp/pip-BImCYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:45:20 INFO - Running setup.py (path:/tmp/pip-V65srJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:45:20 INFO - Running setup.py (path:/tmp/pip-EqlOys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:45:20 INFO - Running setup.py (path:/tmp/pip-4H44A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:45:20 INFO - Running setup.py (path:/tmp/pip-pZz2G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:45:20 INFO - Running setup.py (path:/tmp/pip-zbek3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:45:20 INFO - Running setup.py (path:/tmp/pip-2wt3O_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:45:20 INFO - Running setup.py (path:/tmp/pip-4nRaKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:45:20 INFO - Running setup.py (path:/tmp/pip-iBCXq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:45:20 INFO - Running setup.py (path:/tmp/pip-DtkU3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:45:20 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)) 09:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:45:20 INFO - Running setup.py (path:/tmp/pip-EsJw4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:45:21 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)) 09:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:45:21 INFO - Running setup.py (path:/tmp/pip-eyTUhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:45:21 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)) 09:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:45:21 INFO - Running setup.py (path:/tmp/pip-PzWSmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:45:21 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)) 09:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:21 INFO - Running setup.py (path:/tmp/pip-3WIB4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:45:21 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)) 09:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:45:21 INFO - Running setup.py (path:/tmp/pip-HgDq7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:45:21 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)) 09:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:45:21 INFO - Running setup.py (path:/tmp/pip-VQM7E6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:45:21 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)) 09:45:21 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)) 09:45:21 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)) 09:45:21 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)) 09:45:21 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)) 09:45:21 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)) 09:45:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - Downloading blessings-1.5.1.tar.gz 09:45:23 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 09:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:45:23 INFO - Installing collected packages: blessings 09:45:23 INFO - Running setup.py install for blessings 09:45:23 INFO - Successfully installed blessings 09:45:23 INFO - Cleaning up... 09:45:23 INFO - Return code: 0 09:45:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:45:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:23 INFO - Reading from file tmpfile_stdout 09:45:23 INFO - Current package versions: 09:45:23 INFO - argparse == 1.2.1 09:45:23 INFO - blessings == 1.5.1 09:45:23 INFO - blobuploader == 1.2.4 09:45:23 INFO - docopt == 0.6.1 09:45:23 INFO - manifestparser == 1.1 09:45:23 INFO - mozInstall == 1.12 09:45:23 INFO - mozcrash == 0.16 09:45:23 INFO - mozdebug == 0.1 09:45:23 INFO - mozdevice == 0.47 09:45:23 INFO - mozfile == 1.2 09:45:23 INFO - mozhttpd == 0.7 09:45:23 INFO - mozinfo == 0.9 09:45:23 INFO - mozleak == 0.1 09:45:23 INFO - mozlog == 3.1 09:45:23 INFO - moznetwork == 0.27 09:45:23 INFO - mozprocess == 0.22 09:45:23 INFO - mozprofile == 0.27 09:45:23 INFO - mozrunner == 6.11 09:45:23 INFO - mozscreenshot == 0.1 09:45:23 INFO - mozsystemmonitor == 0.0 09:45:23 INFO - moztest == 0.7 09:45:23 INFO - mozversion == 1.4 09:45:23 INFO - psutil == 3.1.1 09:45:23 INFO - requests == 1.2.3 09:45:23 INFO - wsgiref == 0.1.2 09:45:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:45:23 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')]} 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 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')]} 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:23 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 09:45:23 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 09:45:23 INFO - Using env: {'DISPLAY': ':0', 09:45:23 INFO - 'HOME': '/home/cltbld', 09:45:23 INFO - 'LANG': 'en_US.UTF-8', 09:45:23 INFO - 'LANGUAGE': 'en_US:en', 09:45:23 INFO - 'LOGNAME': 'cltbld', 09:45:23 INFO - 'MAIL': '/var/mail/cltbld', 09:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:23 INFO - 'MOZ_NO_REMOTE': '1', 09:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:23 INFO - 'NO_EM_RESTART': '1', 09:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:23 INFO - 'PWD': '/builds/slave/test', 09:45:23 INFO - 'SHELL': '/bin/bash', 09:45:23 INFO - 'SHLVL': '1', 09:45:23 INFO - 'TERM': 'linux', 09:45:23 INFO - 'TMOUT': '86400', 09:45:23 INFO - 'USER': 'cltbld', 09:45:23 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:23 INFO - '_': '/tools/buildbot/bin/python'} 09:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 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)) 09:45:23 INFO - Cleaning up... 09:45:23 INFO - Return code: 0 09:45:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:45:23 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')]} 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 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')]} 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:23 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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:23 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 09:45:23 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 09:45:23 INFO - Using env: {'DISPLAY': ':0', 09:45:23 INFO - 'HOME': '/home/cltbld', 09:45:23 INFO - 'LANG': 'en_US.UTF-8', 09:45:23 INFO - 'LANGUAGE': 'en_US:en', 09:45:23 INFO - 'LOGNAME': 'cltbld', 09:45:23 INFO - 'MAIL': '/var/mail/cltbld', 09:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:23 INFO - 'MOZ_NO_REMOTE': '1', 09:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:23 INFO - 'NO_EM_RESTART': '1', 09:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:23 INFO - 'PWD': '/builds/slave/test', 09:45:23 INFO - 'SHELL': '/bin/bash', 09:45:23 INFO - 'SHLVL': '1', 09:45:23 INFO - 'TERM': 'linux', 09:45:23 INFO - 'TMOUT': '86400', 09:45:23 INFO - 'USER': 'cltbld', 09:45:23 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:23 INFO - '_': '/tools/buildbot/bin/python'} 09:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:23 INFO - Downloading/unpacking jsonschema 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:45:25 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 09:45:25 INFO - Downloading/unpacking functools32 (from jsonschema) 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:45:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:45:25 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:45:25 INFO - warning: no files found matching '*.txt' 09:45:25 INFO - no previously-included directories found matching 'build' 09:45:25 INFO - no previously-included directories found matching 'dist' 09:45:25 INFO - no previously-included directories found matching '.git*' 09:45:25 INFO - Installing collected packages: jsonschema, functools32 09:45:25 INFO - Running setup.py install for functools32 09:45:26 INFO - warning: no files found matching '*.txt' 09:45:26 INFO - no previously-included directories found matching 'build' 09:45:26 INFO - no previously-included directories found matching 'dist' 09:45:26 INFO - no previously-included directories found matching '.git*' 09:45:26 INFO - Successfully installed jsonschema functools32 09:45:26 INFO - Cleaning up... 09:45:26 INFO - Return code: 0 09:45:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:45:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:45:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:45:26 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 0x7fb9fb9e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2481240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, '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': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', '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 09:45:26 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 09:45:26 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 09:45:26 INFO - Using env: {'DISPLAY': ':0', 09:45:26 INFO - 'HOME': '/home/cltbld', 09:45:26 INFO - 'LANG': 'en_US.UTF-8', 09:45:26 INFO - 'LANGUAGE': 'en_US:en', 09:45:26 INFO - 'LOGNAME': 'cltbld', 09:45:26 INFO - 'MAIL': '/var/mail/cltbld', 09:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:26 INFO - 'MOZ_NO_REMOTE': '1', 09:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:26 INFO - 'NO_EM_RESTART': '1', 09:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:26 INFO - 'PWD': '/builds/slave/test', 09:45:26 INFO - 'SHELL': '/bin/bash', 09:45:26 INFO - 'SHLVL': '1', 09:45:26 INFO - 'TERM': 'linux', 09:45:26 INFO - 'TMOUT': '86400', 09:45:26 INFO - 'USER': 'cltbld', 09:45:26 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:26 INFO - '_': '/tools/buildbot/bin/python'} 09:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:45:26 INFO - Downloading/unpacking flake8 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:26 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 09:45:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:45:27 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 09:45:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:27 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 09:45:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:45:28 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 09:45:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 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 09:45:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:28 INFO - no previously-included directories found matching 'docs/_build' 09:45:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:45:28 INFO - Running setup.py install for pep8 09:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:45:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:45:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:45:28 INFO - no previously-included directories found matching 'docs/_build' 09:45:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:45:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:45:28 INFO - Cleaning up... 09:45:28 INFO - Return code: 0 09:45:28 INFO - Running post-action listener: _resource_record_post_action 09:45:28 INFO - Running post-action listener: _start_resource_monitoring 09:45:28 INFO - Starting resource monitoring. 09:45:28 INFO - ##### 09:45:28 INFO - ##### Running install step. 09:45:28 INFO - ##### 09:45:28 INFO - Running pre-action listener: _resource_record_pre_action 09:45:28 INFO - Running main action method: install 09:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:45:29 INFO - Reading from file tmpfile_stdout 09:45:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:45:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:45:29 INFO - Reading from file tmpfile_stdout 09:45:29 INFO - Output received: 09:45:29 INFO - Usage: mozinstall [options] installer 09:45:29 INFO - Options: 09:45:29 INFO - -h, --help show this help message and exit 09:45:29 INFO - -d DEST, --destination=DEST 09:45:29 INFO - Directory to install application into. [default: 09:45:29 INFO - "/builds/slave/test"] 09:45:29 INFO - --app=APP Application being installed. [default: firefox] 09:45:29 INFO - mkdir: /builds/slave/test/build/application 09:45:29 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'] 09:45:29 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 09:45:44 INFO - Reading from file tmpfile_stdout 09:45:44 INFO - Output received: 09:45:44 INFO - /builds/slave/test/build/application/firefox/firefox 09:45:44 INFO - Running post-action listener: _resource_record_post_action 09:45:44 INFO - ##### 09:45:44 INFO - ##### Running run-tests step. 09:45:44 INFO - ##### 09:45:44 INFO - Running pre-action listener: _resource_record_pre_action 09:45:44 INFO - Running main action method: run_tests 09:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:45:44 INFO - Python 2.7.3 09:45:44 INFO - Return code: 0 09:45:44 INFO - grabbing minidump binary from tooltool 09:45:44 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')]} 09:45:44 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 0x25100b0>, '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 0x2510fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:45:44 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 09:45:44 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 09:45:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:45:44 INFO - Return code: 0 09:45:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:45:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:45:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:45:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:45:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:45:45 INFO - Return code: 0 09:45:45 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/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost'] in /builds/slave/test/build 09:45:45 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/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost 09:45:45 INFO - Using env: {'DISPLAY': ':0', 09:45:45 INFO - 'HOME': '/home/cltbld', 09:45:45 INFO - 'LANG': 'en_US.UTF-8', 09:45:45 INFO - 'LANGUAGE': 'en_US:en', 09:45:45 INFO - 'LOGNAME': 'cltbld', 09:45:45 INFO - 'MAIL': '/var/mail/cltbld', 09:45:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:45:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:45:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:45:45 INFO - 'MOZ_NO_REMOTE': '1', 09:45:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:45:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:45:45 INFO - 'NO_EM_RESTART': '1', 09:45:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:45:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:45:45 INFO - 'PWD': '/builds/slave/test', 09:45:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:45:45 INFO - 'SHELL': '/bin/bash', 09:45:45 INFO - 'SHLVL': '1', 09:45:45 INFO - 'TERM': 'linux', 09:45:45 INFO - 'TMOUT': '86400', 09:45:45 INFO - 'USER': 'cltbld', 09:45:45 INFO - 'XDG_SESSION_COOKIE': '21869f6c619b95355032545b000001da-1449855475.259692-441896371', 09:45:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:45:45 INFO - '_': '/tools/buildbot/bin/python'} 09:45:45 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/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost'] with output_timeout 3600 09:45:46 INFO - mozversion INFO | application_buildid: 20151211083734 09:45:46 INFO - mozversion INFO | application_changeset: 68963ed12683861d6ba5cdc29bdc83124c5577c7 09:45:46 INFO - mozversion INFO | application_display_name: Nightly 09:45:46 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:45:46 INFO - mozversion INFO | application_name: Firefox 09:45:46 INFO - mozversion INFO | application_remotingname: firefox 09:45:46 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 09:45:46 INFO - mozversion INFO | application_vendor: Mozilla 09:45:46 INFO - mozversion INFO | application_version: 45.0a1 09:45:46 INFO - mozversion INFO | platform_buildid: 20151211083734 09:45:46 INFO - mozversion INFO | platform_changeset: 68963ed12683861d6ba5cdc29bdc83124c5577c7 09:45:46 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 09:45:46 INFO - mozversion INFO | platform_version: 45.0a1 09:45:46 INFO - 2015-12-11 09:45:46,056 DEBUG : using testdate: 1449855946 09:45:46 INFO - 2015-12-11 09:45:46,056 DEBUG : actual date: 1449855946 09:45:46 INFO - 2015-12-11 09:45:46,065 INFO : starting webserver on 'localhost:60346' 09:45:46 INFO - 2015-12-11 09:45:46,066 INFO : Starting test suite talos-linux64-ix-003 09:45:46 INFO - 2015-12-11 09:45:46,067 INFO : Starting test dromaeo_css 09:45:46 INFO - 2015-12-11 09:45:46,067 DEBUG : operating with platform_type : linux_ 09:45:46 INFO - 2015-12-11 09:45:46,067 INFO : Initialising browser for dromaeo_css test... 09:45:46 INFO - 2015-12-11 09:45:46,081 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZP3LRt/profile http://localhost:60346/getInfo.html 09:45:50 INFO - 2015-12-11 09:45:50,417 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:45:50 INFO - 2015-12-11 09:45:50,417 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:45:50 INFO - 2015-12-11 09:45:50,417 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:45:50 INFO - 2015-12-11 09:45:50,417 DEBUG : BROWSER_OUTPUT: __metrics 09:45:50 INFO - 2015-12-11 09:45:50,534 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] 09:45:50 INFO - 2015-12-11 09:45:50,595 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] 09:45:50 INFO - 2015-12-11 09:45:50,885 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 09:45:51 INFO - 2015-12-11 09:45:51,551 INFO : Browser initialized. 09:45:51 INFO - 2015-12-11 09:45:51,552 INFO : Running cycle 1/1 for dromaeo_css test... 09:45:51 INFO - 2015-12-11 09:45:51,552 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZP3LRt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:46:03 INFO - 2015-12-11 09:46:03,517 DEBUG : BROWSER_OUTPUT: RSS: Main: 140771328 09:46:03 INFO - 2015-12-11 09:46:03,517 DEBUG : BROWSER_OUTPUT: 09:46:54 INFO - 2015-12-11 09:46:54,720 DEBUG : BROWSER_OUTPUT: 1449856014716 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] 09:49:06 INFO - 2015-12-11 09:49:06,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60346/tests/dromaeo/cssquery-ext.html) 09:49:07 INFO - 2015-12-11 09:49:07,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 271310848 09:49:07 INFO - 2015-12-11 09:49:07,798 DEBUG : BROWSER_OUTPUT: 09:52:10 INFO - 2015-12-11 09:52:10,425 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/dromaeo/cssquery-ext.html (next: http://localhost:60346/tests/dromaeo/cssquery-jquery.html) 09:52:11 INFO - 2015-12-11 09:52:11,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 215642112 09:52:11 INFO - 2015-12-11 09:52:11,007 DEBUG : BROWSER_OUTPUT: 09:55:13 INFO - 2015-12-11 09:55:13,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60346/tests/dromaeo/cssquery-mootools.html) 09:55:13 INFO - 2015-12-11 09:55:13,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 211664896 09:55:13 INFO - 2015-12-11 09:55:13,622 DEBUG : BROWSER_OUTPUT: 09:58:15 INFO - 2015-12-11 09:58:15,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60346/tests/dromaeo/cssquery-prototype.html) 09:58:16 INFO - 2015-12-11 09:58:16,201 DEBUG : BROWSER_OUTPUT: RSS: Main: 202797056 09:58:16 INFO - 2015-12-11 09:58:16,201 DEBUG : BROWSER_OUTPUT: 10:01:18 INFO - 2015-12-11 10:01:18,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60346/tests/dromaeo/cssquery-yui.html) 10:01:19 INFO - 2015-12-11 10:01:19,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 182124544 10:01:19 INFO - 2015-12-11 10:01:19,554 DEBUG : BROWSER_OUTPUT: 10:04:21 INFO - 2015-12-11 10:04:21,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/dromaeo/cssquery-yui.html (next: http://localhost:60346/tests/dromaeo/cssquery-dojo.html) 10:04:22 INFO - 2015-12-11 10:04:22,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 252297216 10:04:22 INFO - 2015-12-11 10:04:22,067 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,068 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:04:22 INFO - 2015-12-11 10:04:22,068 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:04:22 INFO - 2015-12-11 10:04:22,068 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:04:22 INFO - 2015-12-11 10:04:22,069 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:04:22 INFO - 2015-12-11 10:04:22,070 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2609.634651148839;2710.728927107288;2713.7150599187084;2728.277006593252;2737.8220415672986;4378.56214378562;4586.862394128173;4642.698224615402;4706.905861882765;4711.411073615798;4607.10161518504;4608.331791890174;4680.6957547759375;4680.6957547759375;4727.52724727527;4298.935515967263;4357.2592659248;4366.214081465343;4437.223485889973;4442.244818380883;4377.912441751163;4410;4442.267025940716;4443.4445694288215;4474.709143905652;4176.123014167013;4238.682098842568;4293.527711951683;4330.956690433087;4356.215881141393;4316.805743741539;4319.697621166488;4323.243432399349;4349.565043495657;4350.0647360817575;4284.121755040209;4285.5071666758095;4301.397804307399;4301.5698430157045;4338.067315527177;4375.278079116942;4436.534163912775;4446.177457170402;4565.954340456587;4698.295255711637;5067.467915868854;5078.568321692624;5081.695098294114;5088;5098.515641014098;5075.111855425286;5075.847724568269;5088.92366614501;5130.333056702642;5141.5886729061585;4459.264221403497;4562.954370456253;4566.657500687462;4673.556012178838;4675.742834144121;5215.348081489814;5219.217117432339;5221.947780522146;5222.373315202124;5255.921161182585;4995.225740010304;5003.399592048978;5004.174311238678;5008.348914641147;5045.974770126126;4920.532549407801;4972.950270497248;5046.091703493406;5046.44489106198;5105.055564720538;5027;5031.295618613324;5032.521910418504;5052.671576347526;5060.898782024339;5018.949810501848;5021.372328458942;5022.171341728574;5022.899542009212;5065.797368105234;4062.1469491407133;4121.855735049319;4153.02403935075;4156.459660244149;4304.096139810675;3727.6458736419995;3742.7567208131386;3770.7171962102952;3776.5090538229856;3776.6223377662013;4229.471316085489;4278.058827058042;4281.464816897887;4284.293091639907;4320.675949303752;5084.186530155157;5089.312942752755;5094.5669618082875;5096.974515127401;5100.285959965608;4331.393604895317;4338.7830608470085;4343.391925130484;4376.606105450524;4380.167768124046;4300.37644541546;4361.0841723237845;4405.427294451701;4411.713238639478;4511.323301504801;4663.090697313991;4733.408323959505;4738.31294462308;4744.240921452551;4779.593734532604;5025.949740502549;5034.320366750442;5070.543651071422;5072.746362681925;5073.949260507496;4610.492845786894;4664.323673067454;4778.689385189951;4809.495003024772;4857.878553036202;4862.562369386772;4968.22992436173;4970;4971.502849715;5010.448850626355;5065.924011139909;5138.254953031864;5138.306328645585;5142.357205349332;5184.144616138446;4768.403949506312;4907.877303067452;4955.256711493161;4969.35398398206;4974.850754477371;4898.387701537308;4907.214845624826;4922.4339200992345;4923.113839508923;4924.606031517542;4712.316714076508;4780.808767649255;4832.20268655682;4836.854894353034;4867.050925069578;4957.132501812241;4971.279164521196;4972.975135124301;4980.27785971025;4998.2002879539095;4856.1016212000895;4861.538153875376;4865.635077369282;4870.099031679009;4912.435069966999 10:04:22 INFO - 2015-12-11 10:04:22,073 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.7251383079208;567.7615401531357;578.50248786044;580.0342429854293;591.9171316015755;26203;26886.865565672168;34849.65150348496;35488.64511354885;35576.2884742305;39051;39586;39588.80205598968;39600.80199599005;39614.40578391319;7689.730859419921;7995.560244186568;7996.800079997988;8001.599920004006;8002.479838810488;7123.964380178118;7307.2327405622445;10148.188144948386;10363.844542331872;10376.53305601246;9926.900730992706;10088.747781305452;10097.091261786438;10109.443980581065;10120.797584048314;7103.396211322044;7295.088113985752;9934.65228716995;10044.748881277954;10050.09549140581;9916;10185.236107291908;10188.59245630174;10188.898111018869;10191.541380637815;35944.28111437757;36353.63646363529;36434.27131457356;36481;36611.4508282376;2786.965515173914;2839.2617919340914;3017.909462716122;3224.8548815303366;3246.870125194989;28314.575281370795;28386.432271354664;28646;28874.855625721946;28977.13068607945;3262.559554460141;3323.252268239651;3382.0699307690584;3383.9492407613907;3397;205021;205336;207803;208158;208900;50635.24047139296;52018;54439;54857.72571137198;54923.72538137284;58791;59825.70087149536;60008.699956499935;60032.39967600268;60138.097928531104;11906.404679765978;12063.879361206451;12065.698357541132;12073.335966521925;12087.214331068453;9010.819783604291;9104.226140778108;9107.362484626012;9110.088991100836;9115.81768364629;18234.27062917495;18435.631287374177;19171.616567668567;19247.807521924602;19311.517212069528;7708.961455192688;7903.644336004893;8012.1186669466315;8065.596720163969;8070;766.107484780236;797.3103265675265;816.5998660656354;925.9398139120935;928.4661319741176;25049.87475062613;25076.373090672514;25136.748632513805;25220.149346919556;25286.747132528806;855.1363123245443;906.7370462565782;912.8402529557301;922.294444749767;923.385948344357;12953.417096230693;13417.249185303039;13455.461781528826;13497.730045399234;13506.054576179573;302725;307199;307645;307961;308483;47288.76355618269;47799;47853.28220076702;47868.5213147871;47887.76056119697;1166.8191430328313;1172.5016867831137;1204.1390405859852;1218.9634310970685;1235.1415766042514;24404.51190976206;25208.36979075538;25503.872480637478;25553.61669574995;25574;37361.4395784058;37422;37903.43144852885;37911.62088379191;37975;245400;247359;247476;247687;247969;24575.631365529174;25044.874775626005;28352.858235709515;28915;29312.267193319483;32460.837695812315;32539.674603253665;44073.338899917166;45452.77273613743;45509.544904551854;33044.339113217124;33230.83384583062;33550.66449335573;33701.32597348088;33922.49116263307;29658.703412965595;37322;37538.436923445624;38953.80523097367;39260;31956;32051.67948320487;32500.674993250712;32689;32956;29265.858162399392;30590.694093059676;33485;35713.64286357103;35721.64278357287;23199.420014499097;23621.173258935854;23810;23975.160869369487;23980.520389591762 10:04:22 INFO - 2015-12-11 10:04:22,074 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.52020610526944;336.78782367108704;338.0585070578438;338.60383351478765;343.30994700651684;12159.209651372677;12545.874541254585;15177.544673659793;15229.314680839376;15859.603509912244;14818.184999825005;15095.962045123904;15376.846231537682;15462.69074618507;15580.922095389507;4541.046380260149;4777.856664300077;4897.387826521676;5001.249812528132;5003.39959204896;4938.703677779326;4961.875953101166;4970.627202959774;4974.850754477354;4976.601871850261;4926.926096108561;5032.82385116521;5044.848654540369;5052.292679024939;5114.641975061747;4982.352294201767;5010.599152067844;5022.472640372781;5035.269885866529;5041.294218809369;4373.803178856927;4490.3488994096;4492.393526873863;4495.056038231975;4523.547645235483;19356.903215483973;19432.22271109154;19437.708434373497;19663.508412289808;19857.304994325274;1863.4689113602558;1886.6981282994793;1957.8923159226238;1982.226931496703;1989.980100198994;8370.8325833483;8635.481871087692;8779.517126558037;9048.457092574467;13035.674108147277;1712;1720.1399300349824;1722.285251620576;1722.7329763886617;1758.832910873465;54130.729346353015;55100.17349739797;55292.72353638206;55670.44329556693;55691.44308556903;9742;9823.705288841204;9823.901760982299;9857.570652255527;9867.555959981819;10341.37951722884;10584.364938103738;11891.405429728478;12323;12351.814722779165;6420.871582568416;6547.377999090078;6561.343865613496;6603.504737144734;6607.537472376887;6072.666003369857;6075.058365953284;6153.446189842935;6177.567570270128;6241.313455519889;4077.4699289092227;4083.3262511685834;4104.774237416911;4120.505539335239;4121.814518346621;1677.8909370890854;1718.5703574106474;1724.3533674871924;1736.6266252755465;1739.7651317072286;394.2784703991746;724.4135343597504;786.7757689058706;913.4291068082448;977.2914636888199;9409.388389754644;9609.711708648752;9630.903690963141;9957.402555846527;9971.252156088321;368.48596208289285;388.5337594886091;388.5628667748783;413.85928784213513;427.50623030399936;4629.2824612184495;5484.369297530835;5555;5594.552435805126;8946.418482798597;328671.20979555976;383110;510406;511815;520279;55847;70122;73604;76518.61740691261;76917.61541192258;995.7958618483339;1032.4631191780231;1034.5448002878709;1041.770810421706;1064.0955188090215;14444.133351998493;14690.63273418173;14759.778603320745;14763.335649895995;14869.256537173314;30623.387532249675;31011.84494077515;31012;31814.363712725153;32269.838650806596;41922;42052.36921446242;42601.36097958595;42633;43379.349309759746;8501.234888860032;8826.735197944072;8911.821763564822;8978.820423591622;9114;14119.929400352932;15838.049717017017;15914.124723139876;16063.839361606235;17047.65904681924;13264;13272.27002514871;13519.662008449868;14081.225532595805;14685.19231442281;13650;13727.656808579866;13833.446662133401;13917.304134793018;14017.439302427789;13787.310634468036;13840.584782456543;13996.930015349859;14215.50245741394;14539.200343981183;9044.321675874204;9075.092490750872;9075.092490751136;9103.772405689646;9227.815443690954;13009.804852927024;13080.672983175496;13133.015023873057;13328.800067998794;13863.37614807316 10:04:22 INFO - 2015-12-11 10:04:22,077 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1202.9939850300748;1634.5014770494997;1661.6925868714288;1684.8736344774145;1718.3642052440596;5751.8274451766465;6771.052052712618;6955.791326260208;6962.0601218835445;6970.0938877945855;6682.532222744409;6841.657917104138;6871.4846386521085;6871.587704737719;6874.79375618731;1741.3208848549075;1767.3195819609414;1771.6633839570504;2045.5193029638024;2091.801278878504;1760.2255007796593;1769.1419661464179;1999.6300684373364;2068.25542804591;2068.8758674479577;2012.5069358007308;2023.1806118522022;2032.7357443532394;2035.2673037706413;2036.6435873722114;2089.237428338653;2113.2286715348787;2117.830573554112;2118.947026324339;2118.9934780979065;2047.5393036566802;2064.9380518584467;2068.162394230339;2068.4415207893785;2096.926607568728;6964.129483814523;7022.508424410294;7029.683664235122;7032.331928466839;7059.188193357778;4086.652634526069;4146.170765846843;4147.6474499667565;4152.958470415288;4154.5222299435645;2694.8383097014244;2697.0560303893676;2732.0164740693335;2743.917682469529;2757.6828664703617;825.9958700206521;836.0970152235572;839.1524560194187;841.2512863551444;860.4192170285032;9351.064893510595;9376.95311523438;9379;9379.76550586234;9380.90619093807;3857.2478366718783;3925.7644541327613;3931.4889064422014;3948.58539853317;3973.304671682502;8046.275835174745;8070.47541909774;8085.514869107872;8086.150954149847;8097.919020809834;4087.795610219477;4114.526829414595;4115.115250221217;4133.731307465006;4139.97930010348;3758.6429289218026;3759.2105657812167;3762.4544441055896;3767.6420740029653;3769.7738135711943;2923.0500087471655;3293.884714034997;3342.8161451120422;3370.6966373026544;3371.662833716609;944.3153713557616;1007.5868893753526;1048.491481631408;1052.1267348101057;1065.2862582070031;888.6889588643922;907.3240435875183;915.3135148638521;916.2898753465984;1051.279873286801;6406.327335629785;6479.902801457982;6491.188601424822;6498.740050398026;6515.218173819172;1006.1699098243978;1012.4836333469983;1021.6349151713907;1025.4411345816548;1043.5929987304958;4915.188993816052;4918.163912134945;4964.429090654548;4966.230234313687;4977.9751101244265;7717.65270562826;7889.723859664884;7926.841463170705;7932.762017139495;8056.637451314705;7766.9611651942505;7820.139784623687;7838.255365740246;7838.294553490099;7846.136924938252;6346.619202847844;6515.641639709862;6552.410283074546;6640.966795165993;6678.866422671519;6710.6309152997055;6747.156605424322;6779.93220067793;6800.727970881109;6804.285550017177;7375.151857536237;7554.169041405551;7583.393328533593;7653.57905315213;7654.655540500579;7631;7825.569593672402;7829.765107046797;7842.725504607311;7843.215678432111;6174;6226.377362263737;6227.159333490102;6240.719167637558;6245.094461302995;5389.164679474688;6376.043593461018;6485;6565.113709649328;6567.310432404529;5585.357683866408;6090.451859332681;6125.356837531995;6133.9079913802225;6318.399752023551;6043.607165534227;6091.299500557316;6119.4798442132915;6201.534884883562;6239.438450539473;6208;6264.5301602379095;6275.874482510416;6286.9626511625065;6289.465395441256;5645.661260324394;5663.830085097454;5746.109353050284;5758.884822303614;5767.307923049261;5958.314793798769;5968.492678122235;5994.400559943971;5996.130561068708;6011.549133815069 10:04:22 INFO - 2015-12-11 10:04:22,077 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.15959192017914;310.42261393807513;313.0467725775015;314.89471953443405;316.85583059707835;5269.209618557218;5356.705381204037;5365.195220716884;5366.677999320043;5371.167469042295;5204.9219261711105;5245.160774276116;5246.711430871301;5255.789768409259;5276.472352764722;3902.5512066112333;4009.719319647626;4149.771762553059;4157.272477316473;4160.521540022898;4034.0519977805193;4119.320312148492;4140.668746500272;4169.270377683908;4182.64447521961;4111.075008123164;4123.237201117803;4125.133721918401;4134;4143.02638879863;3874.651281384689;3966.226585815767;3991.5409727881374;4125.566815484391;4136.875893723178;3616.276744651054;3625.274945010982;3648.4709717090873;3649.543807024122;3656.634336566349;5075.111855425286;5076.873078173038;5077.669951453181;5078;5099.107656160157;4741.976290118528;4755.833545825914;4756.405449318835;4757.26262429324;4758.3576217210575;5457.590680698924;5578.3584887738025;5587.469190426903;5591.552675785927;5601.831945041656;3947.8618248361167;3985.720999530034;3990.38149086892;3991.98004009981;4000.5399379071487;5843.5033022193165;5847.26909136358;5852.092925596539;5856.882862342729;5860.17957485948;4083.959160408358;4110.527289361762;4112.547619761824;4112.753234805921;4117.75293482392;4069.552349241581;4157.833686652561;4171.666266698657;4184.995601055785;4187.413762073312;4700.7179569225955;4708.081924024782;4712.929306060412;4712.929306060412;4717.646176536773;5556.91664625031;5562.582806289544;5564.137558678412;5564.666120032811;5567.053600887859;1453.7237924794467;1467.207707837777;1469.0524611625656;1469.0965056490395;1470.9043912145676;1013.2147585621202;1015.2030655935056;1018.332991890313;1037.3827572594294;1037.5331101004579;4870.6103511718975;4871.464138944713;4871.537203965618;4872;4874.902501949941;5719.771209151588;5752.798652047242;5759.913601295984;5765.221695071112;5767.5674324425;4833.468318484964;4849.636277279147;4854.635902307341;4864.951350486521;4866.902661946741;3020.411019851152;3061.6938306169204;3110;3111.284404586958;3112.64204616472;5429.864253393696;5500.724963751796;5502.0371434998715;5507.0637991541535;5518.751656175482;6028.246469191351;6031.788887388921;6032.4570788629235;6033.78881739137;6037.698115094227;5496.587755918402;5517.531009864127;5518.558515318765;5522.585806064561;5523.364813046471;5678.858028549319;5797.768089276382;5847.561432892465;5849.590528662953;5853.590248682722;5677.659340439587;5699.458551437607;5704.914426283692;5706.828795136153;5711.657300561979;5411.377691565521;5470.480304371078;5476.753546090516;5485.424030476743;5490.313710786152;3874.2832575973534;3966.6826653868197;4004.8197831097086;4004.979975100106;4049.1901619675596;5789.884202316014;5793.15999180125;5795.304563452412;5795.710214489174;5804.361520232686;5570.554355651457;5579.888402231852;5583.274174357308;5584.134459158837;5585.5531557476115;5566.109422492544;5570.5265052470995;5574.191742197278;5578.665280083208;5587.888242235052;5303;5494.972525137348;5512.310961129859;5512.3385193777;5520.06158952971;5392.514673679388;5567.55459563242;5643.1535269709875;5651.350094738993;5669.858253543694;5405.702686352289;5516.648421136847;5538.695371754431;5552.7223638818705;5553.361363443256 10:04:22 INFO - 2015-12-11 10:04:22,081 DEBUG : BROWSER_OUTPUT: |5;yui.html;677.7661706711183;722.0324764815147;744.8249661329584;755.2372104174783;770.3567521119863;10532.368057916521;10608.840867386976;10639.468026598668;10670.466476676174;10679.199060070496;11085.390303533302;11291.830622540649;11334.093272538197;11368.09055275578;11373.601923932663;758.8823732321486;779.364817673597;779.4699604269094;780.3873958942231;780.6057940739947;763.2520130272336;771.2827070824131;774.4114473000504;775.0931410250021;775.5036776463069;801.8155824160417;810.1776696652902;810.5906517208801;811.2090711556215;811.407672399146;811.2131232704268;812.4800127918137;812.7846120777998;813.2883726739103;813.3899575318511;600.1747597054051;600.9729562169713;601.0833478944601;601.1613798750718;601.3595520770366;10110.64612738558;10165;10174.236932230113;10189.184865210766;10210.693679189637;8847.77880552985;9587.280953928414;9669.806603867883;9725.610975560969;9931.205503559699;7954.522728636301;8124.796880077986;8169.30560902324;8250.793730156734;8304.418690691655;3121.0480803354967;3209.5988001499813;3223.9355212895844;3226.9677303226904;3239.3683231769814;31455.52816707751;35389.823050884836;38269.61730382688;43313.78343108296;43375.78312108419;9209.631614735335;9299.581518831668;9305.953470232605;9402.529873506297;9580.0898914603;16485.83514164867;16504.42234521786;16594.336226550804;16638.75041874373;16648.417305394254;6041.395860413923;6068.302145253264;6087.1173679816175;6137.324894261627;6145.293291271471;3497.3355062538544;3515.7538972271695;3577.94633080504;3589.515415418937;3641.1807343348064;2669.7196794336705;2679.142674344191;2685.3018215264174;2686.2478506018347;2686.7984901132104;462.5305315105171;463.10851610650036;465.6531083339996;472.37410431178824;473.43424607593596;424.27449062103534;491.43730428658984;503.39843886555946;542.2002546244337;544.4256309593417;7055.823604409931;7108.857822843514;7408.814779630445;7651.5409075455655;7752.224777522202;515.5025400488472;521.4628932199764;521.6531006880382;544.7303584725586;555.0397811785552;3397.456406974872;3701.7964011979598;3706.40478735626;3747.7001839852746;3760.981195094007;41169.17661646751;41173.38239926403;41483.1703365937;41688.58311416847;44028.3395749064;34557;37847;39675;41619.37570936439;41719.1656166881;37539.81230093832;37864.62135378611;38005.61994380076;38719.80640096838;39500.604993950845;7778.611069446391;8056.36680070814;8093.554854482824;8285.047219569826;8289.461185022954;29823;29855;30051.84974075203;30391.39217215599;31698.366032679678;37964.810175948944;38390.23219535538;38399.42400863933;38529.22941541098;38831;9166.770830729285;9842.415529832255;10011.048950349705;10227.795444091225;10232.693019209435;10550.143779663786;10701.411422371533;10733.27414737314;10948.124150068135;10976.560937562408;10665.253432259668;10703.464826758787;10758.354498730101;10844.132469402586;11057.834132487858;10464.895351046393;10612.28545170018;10760.569577216824;10924.781504369708;11074.5570177192;9304.30217733659;9328.860067098864;9483.193928516153;9611.567479463301;9626.66306679291;9339.112784285482;9358.204552612831;9526.476043817656;9784.608615655294;9964.800703985735;9302;9483.8635672213;9486.478243696387;9508.619655213713;9592.66425675098 10:04:22 INFO - 2015-12-11 10:04:22,081 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:04:22 INFO - 2015-12-11 10:04:22,081 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:04:22 INFO - 2015-12-11 10:04:22,081 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1075 10:04:22 INFO - 2015-12-11 10:04:22,081 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857062067__endTimestamp 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4649.81 Median:4768.40 stddev:495.05 (10.4%) stddev-sans-first:469.99 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: Values: 2609.6 2710.7 2713.7 2728.3 2737.8 4378.6 4586.9 4642.7 4706.9 4711.4 4607.1 4608.3 4680.7 4680.7 4727.5 4298.9 4357.3 4366.2 4437.2 4442.2 4377.9 4410.0 4442.3 4443.4 4474.7 4176.1 4238.7 4293.5 4331.0 4356.2 4316.8 4319.7 4323.2 4349.6 4350.1 4284.1 4285.5 4301.4 4301.6 4338.1 4375.3 4436.5 4446.2 4566.0 4698.3 5067.5 5078.6 5081.7 5088.0 5098.5 5075.1 5075.8 5088.9 5130.3 5141.6 4459.3 4563.0 4566.7 4673.6 4675.7 5215.3 5219.2 5221.9 5222.4 5255.9 4995.2 5003.4 5004.2 5008.3 5046.0 4920.5 4973.0 5046.1 5046.4 5105.1 5027.0 5031.3 5032.5 5052.7 5060.9 5018.9 5021.4 5022.2 5022.9 5065.8 4062.1 4121.9 4153.0 4156.5 4304.1 3727.6 3742.8 3770.7 3776.5 3776.6 4229.5 4278.1 4281.5 4284.3 4320.7 5084.2 5089.3 5094.6 5097.0 5100.3 4331.4 4338.8 4343.4 4376.6 4380.2 4300.4 4361.1 4405.4 4411.7 4511.3 4663.1 4733.4 4738.3 4744.2 4779.6 5025.9 5034.3 5070.5 5072.7 5073.9 4610.5 4664.3 4778.7 4809.5 4857.9 4862.6 4968.2 4970.0 4971.5 5010.4 5065.9 5138.3 5138.3 5142.4 5184.1 4768.4 4907.9 4955.3 4969.4 4974.9 4898.4 4907.2 4922.4 4923.1 4924.6 4712.3 4780.8 4832.2 4836.9 4867.1 4957.1 4971.3 4973.0 4980.3 4998.2 4856.1 4861.5 4865.6 4870.1 4912.4 10:04:22 INFO - 2015-12-11 10:04:22,082 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41389.26 Median:33000.17 stddev:67144.54 (203.5%) stddev-sans-first:67262.93 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: Values: 566.7 567.8 578.5 580.0 591.9 26203.0 26886.9 34849.7 35488.6 35576.3 39051.0 39586.0 39588.8 39600.8 39614.4 7689.7 7995.6 7996.8 8001.6 8002.5 7124.0 7307.2 10148.2 10363.8 10376.5 9926.9 10088.7 10097.1 10109.4 10120.8 7103.4 7295.1 9934.7 10044.7 10050.1 9916.0 10185.2 10188.6 10188.9 10191.5 35944.3 36353.6 36434.3 36481.0 36611.5 2787.0 2839.3 3017.9 3224.9 3246.9 28314.6 28386.4 28646.0 28874.9 28977.1 3262.6 3323.3 3382.1 3383.9 3397.0 205021.0 205336.0 207803.0 208158.0 208900.0 50635.2 52018.0 54439.0 54857.7 54923.7 58791.0 59825.7 60008.7 60032.4 60138.1 11906.4 12063.9 12065.7 12073.3 12087.2 9010.8 9104.2 9107.4 9110.1 9115.8 18234.3 18435.6 19171.6 19247.8 19311.5 7709.0 7903.6 8012.1 8065.6 8070.0 766.1 797.3 816.6 925.9 928.5 25049.9 25076.4 25136.7 25220.1 25286.7 855.1 906.7 912.8 922.3 923.4 12953.4 13417.2 13455.5 13497.7 13506.1 302725.0 307199.0 307645.0 307961.0 308483.0 47288.8 47799.0 47853.3 47868.5 47887.8 1166.8 1172.5 1204.1 1219.0 1235.1 24404.5 25208.4 25503.9 25553.6 25574.0 37361.4 37422.0 37903.4 37911.6 37975.0 245400.0 247359.0 247476.0 247687.0 247969.0 24575.6 25044.9 28352.9 28915.0 29312.3 32460.8 32539.7 44073.3 45452.8 45509.5 33044.3 33230.8 33550.7 33701.3 33922.5 29658.7 37322.0 37538.4 38953.8 39260.0 31956.0 32051.7 32500.7 32689.0 32956.0 29265.9 30590.7 33485.0 35713.6 35721.6 23199.4 23621.2 23810.0 23975.2 23980.5 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24961.97 Median:2267.84 stddev:74916.90 (3303.5%) stddev-sans-first:75104.24 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: Values: 335.5 336.8 338.1 338.6 343.3 12159.2 12545.9 15177.5 15229.3 15859.6 14818.2 15096.0 15376.8 15462.7 15580.9 4541.0 4777.9 4897.4 5001.2 5003.4 4938.7 4961.9 4970.6 4974.9 4976.6 4926.9 5032.8 5044.8 5052.3 5114.6 4982.4 5010.6 5022.5 5035.3 5041.3 4373.8 4490.3 4492.4 4495.1 4523.5 19356.9 19432.2 19437.7 19663.5 19857.3 1863.5 1886.7 1957.9 1982.2 1990.0 8370.8 8635.5 8779.5 9048.5 13035.7 1712.0 1720.1 1722.3 1722.7 1758.8 54130.7 55100.2 55292.7 55670.4 55691.4 9742.0 9823.7 9823.9 9857.6 9867.6 10341.4 10584.4 11891.4 12323.0 12351.8 6420.9 6547.4 6561.3 6603.5 6607.5 6072.7 6075.1 6153.4 6177.6 6241.3 4077.5 4083.3 4104.8 4120.5 4121.8 1677.9 1718.6 1724.4 1736.6 1739.8 394.3 724.4 786.8 913.4 977.3 9409.4 9609.7 9630.9 9957.4 9971.3 368.5 388.5 388.6 413.9 427.5 4629.3 5484.4 5555.0 5594.6 8946.4 328671.2 383110.0 510406.0 511815.0 520279.0 55847.0 70122.0 73604.0 76518.6 76917.6 995.8 1032.5 1034.5 1041.8 1064.1 14444.1 14690.6 14759.8 14763.3 14869.3 30623.4 31011.8 31012.0 31814.4 32269.8 41922.0 42052.4 42601.4 42633.0 43379.3 8501.2 8826.7 8911.8 8978.8 9114.0 14119.9 15838.0 15914.1 16063.8 17047.7 13264.0 13272.3 13519.7 14081.2 14685.2 13650.0 13727.7 13833.4 13917.3 14017.4 13787.3 13840.6 13996.9 14215.5 14539.2 9044.3 9075.1 9075.1 9103.8 9227.8 13009.8 13080.7 13133.0 13328.8 13863.4 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4828.52 Median:6105.39 stddev:2478.97 (40.6%) stddev-sans-first:2470.94 10:04:22 INFO - 2015-12-11 10:04:22,083 DEBUG : BROWSER_OUTPUT: Values: 1203.0 1634.5 1661.7 1684.9 1718.4 5751.8 6771.1 6955.8 6962.1 6970.1 6682.5 6841.7 6871.5 6871.6 6874.8 1741.3 1767.3 1771.7 2045.5 2091.8 1760.2 1769.1 1999.6 2068.3 2068.9 2012.5 2023.2 2032.7 2035.3 2036.6 2089.2 2113.2 2117.8 2118.9 2119.0 2047.5 2064.9 2068.2 2068.4 2096.9 6964.1 7022.5 7029.7 7032.3 7059.2 4086.7 4146.2 4147.6 4153.0 4154.5 2694.8 2697.1 2732.0 2743.9 2757.7 826.0 836.1 839.2 841.3 860.4 9351.1 9377.0 9379.0 9379.8 9380.9 3857.2 3925.8 3931.5 3948.6 3973.3 8046.3 8070.5 8085.5 8086.2 8097.9 4087.8 4114.5 4115.1 4133.7 4140.0 3758.6 3759.2 3762.5 3767.6 3769.8 2923.1 3293.9 3342.8 3370.7 3371.7 944.3 1007.6 1048.5 1052.1 1065.3 888.7 907.3 915.3 916.3 1051.3 6406.3 6479.9 6491.2 6498.7 6515.2 1006.2 1012.5 1021.6 1025.4 1043.6 4915.2 4918.2 4964.4 4966.2 4978.0 7717.7 7889.7 7926.8 7932.8 8056.6 7767.0 7820.1 7838.3 7838.3 7846.1 6346.6 6515.6 6552.4 6641.0 6678.9 6710.6 6747.2 6779.9 6800.7 6804.3 7375.2 7554.2 7583.4 7653.6 7654.7 7631.0 7825.6 7829.8 7842.7 7843.2 6174.0 6226.4 6227.2 6240.7 6245.1 5389.2 6376.0 6485.0 6565.1 6567.3 5585.4 6090.5 6125.4 6133.9 6318.4 6043.6 6091.3 6119.5 6201.5 6239.4 6208.0 6264.5 6275.9 6287.0 6289.5 5645.7 5663.8 5746.1 5758.9 5767.3 5958.3 5968.5 5994.4 5996.1 6011.5 10:04:22 INFO - 2015-12-11 10:04:22,084 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,084 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4645.22 Median:5225.04 stddev:1353.70 (25.9%) stddev-sans-first:1317.74 10:04:22 INFO - 2015-12-11 10:04:22,085 DEBUG : BROWSER_OUTPUT: Values: 306.2 310.4 313.0 314.9 316.9 5269.2 5356.7 5365.2 5366.7 5371.2 5204.9 5245.2 5246.7 5255.8 5276.5 3902.6 4009.7 4149.8 4157.3 4160.5 4034.1 4119.3 4140.7 4169.3 4182.6 4111.1 4123.2 4125.1 4134.0 4143.0 3874.7 3966.2 3991.5 4125.6 4136.9 3616.3 3625.3 3648.5 3649.5 3656.6 5075.1 5076.9 5077.7 5078.0 5099.1 4742.0 4755.8 4756.4 4757.3 4758.4 5457.6 5578.4 5587.5 5591.6 5601.8 3947.9 3985.7 3990.4 3992.0 4000.5 5843.5 5847.3 5852.1 5856.9 5860.2 4084.0 4110.5 4112.5 4112.8 4117.8 4069.6 4157.8 4171.7 4185.0 4187.4 4700.7 4708.1 4712.9 4712.9 4717.6 5556.9 5562.6 5564.1 5564.7 5567.1 1453.7 1467.2 1469.1 1469.1 1470.9 1013.2 1015.2 1018.3 1037.4 1037.5 4870.6 4871.5 4871.5 4872.0 4874.9 5719.8 5752.8 5759.9 5765.2 5767.6 4833.5 4849.6 4854.6 4865.0 4866.9 3020.4 3061.7 3110.0 3111.3 3112.6 5429.9 5500.7 5502.0 5507.1 5518.8 6028.2 6031.8 6032.5 6033.8 6037.7 5496.6 5517.5 5518.6 5522.6 5523.4 5678.9 5797.8 5847.6 5849.6 5853.6 5677.7 5699.5 5704.9 5706.8 5711.7 5411.4 5470.5 5476.8 5485.4 5490.3 3874.3 3966.7 4004.8 4005.0 4049.2 5789.9 5793.2 5795.3 5795.7 5804.4 5570.6 5579.9 5583.3 5584.1 5585.6 5566.1 5570.5 5574.2 5578.7 5587.9 5303.0 5495.0 5512.3 5512.3 5520.1 5392.5 5567.6 5643.2 5651.4 5669.9 5405.7 5516.6 5538.7 5552.7 5553.4 10:04:22 INFO - 2015-12-11 10:04:22,085 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,085 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11491.68 Median:464.38 stddev:12604.14 (2714.2%) stddev-sans-first:12613.33 10:04:22 INFO - 2015-12-11 10:04:22,085 DEBUG : BROWSER_OUTPUT: Values: 677.8 722.0 744.8 755.2 770.4 10532.4 10608.8 10639.5 10670.5 10679.2 11085.4 11291.8 11334.1 11368.1 11373.6 758.9 779.4 779.5 780.4 780.6 763.3 771.3 774.4 775.1 775.5 801.8 810.2 810.6 811.2 811.4 811.2 812.5 812.8 813.3 813.4 600.2 601.0 601.1 601.2 601.4 10110.6 10165.0 10174.2 10189.2 10210.7 8847.8 9587.3 9669.8 9725.6 9931.2 7954.5 8124.8 8169.3 8250.8 8304.4 3121.0 3209.6 3223.9 3227.0 3239.4 31455.5 35389.8 38269.6 43313.8 43375.8 9209.6 9299.6 9306.0 9402.5 9580.1 16485.8 16504.4 16594.3 16638.8 16648.4 6041.4 6068.3 6087.1 6137.3 6145.3 3497.3 3515.8 3577.9 3589.5 3641.2 2669.7 2679.1 2685.3 2686.2 2686.8 462.5 463.1 465.7 472.4 473.4 424.3 491.4 503.4 542.2 544.4 7055.8 7108.9 7408.8 7651.5 7752.2 515.5 521.5 521.7 544.7 555.0 3397.5 3701.8 3706.4 3747.7 3761.0 41169.2 41173.4 41483.2 41688.6 44028.3 34557.0 37847.0 39675.0 41619.4 41719.2 37539.8 37864.6 38005.6 38719.8 39500.6 7778.6 8056.4 8093.6 8285.0 8289.5 29823.0 29855.0 30051.8 30391.4 31698.4 37964.8 38390.2 38399.4 38529.2 38831.0 9166.8 9842.4 10011.0 10227.8 10232.7 10550.1 10701.4 10733.3 10948.1 10976.6 10665.3 10703.5 10758.4 10844.1 11057.8 10464.9 10612.3 10760.6 10924.8 11074.6 9304.3 9328.9 9483.2 9611.6 9626.7 9339.1 9358.2 9526.5 9784.6 9964.8 9302.0 9483.9 9486.5 9508.6 9592.7 10:04:22 INFO - 2015-12-11 10:04:22,086 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:04:22 INFO - 2015-12-11 10:04:22,086 DEBUG : BROWSER_OUTPUT: 10:04:22 INFO - 2015-12-11 10:04:22,792 INFO : Browser exited with error code: 0 10:04:22 INFO - 2015-12-11 10:04:22,815 INFO : Completed test dromaeo_css (00:18:36) 10:04:22 INFO - 2015-12-11 10:04:22,815 INFO : Starting test kraken 10:04:22 INFO - 2015-12-11 10:04:22,815 DEBUG : operating with platform_type : linux_ 10:04:22 INFO - 2015-12-11 10:04:22,815 INFO : Initialising browser for kraken test... 10:04:22 INFO - 2015-12-11 10:04:22,822 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRR5OKZ/profile http://localhost:60346/getInfo.html 10:04:26 INFO - 2015-12-11 10:04:26,791 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:04:26 INFO - 2015-12-11 10:04:26,792 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:04:26 INFO - 2015-12-11 10:04:26,792 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:04:26 INFO - 2015-12-11 10:04:26,792 DEBUG : BROWSER_OUTPUT: __metrics 10:04:26 INFO - 2015-12-11 10:04:26,920 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] 10:04:26 INFO - 2015-12-11 10:04:26,976 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] 10:04:28 INFO - 2015-12-11 10:04:28,091 INFO : Browser initialized. 10:04:28 INFO - 2015-12-11 10:04:28,091 INFO : Running cycle 1/1 for kraken test... 10:04:28 INFO - 2015-12-11 10:04:28,092 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRR5OKZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:04:40 INFO - 2015-12-11 10:04:40,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 143441920 10:04:40 INFO - 2015-12-11 10:04:40,063 DEBUG : BROWSER_OUTPUT: 10:04:42 INFO - 2015-12-11 10:04:42,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60346/tests/kraken/driver.html?testName=audio-beat-detection) 10:04:43 INFO - 2015-12-11 10:04:43,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 179900416 10:04:43 INFO - 2015-12-11 10:04:43,280 DEBUG : BROWSER_OUTPUT: 10:04:46 INFO - 2015-12-11 10:04:46,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60346/tests/kraken/driver.html?testName=audio-dft) 10:04:46 INFO - 2015-12-11 10:04:46,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 168574976 10:04:46 INFO - 2015-12-11 10:04:46,610 DEBUG : BROWSER_OUTPUT: 10:04:49 INFO - 2015-12-11 10:04:49,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60346/tests/kraken/driver.html?testName=audio-fft) 10:04:50 INFO - 2015-12-11 10:04:50,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 152674304 10:04:50 INFO - 2015-12-11 10:04:50,166 DEBUG : BROWSER_OUTPUT: 10:04:52 INFO - 2015-12-11 10:04:52,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60346/tests/kraken/driver.html?testName=audio-oscillator) 10:04:52 INFO - 2015-12-11 10:04:52,778 DEBUG : BROWSER_OUTPUT: RSS: Main: 154710016 10:04:52 INFO - 2015-12-11 10:04:52,778 DEBUG : BROWSER_OUTPUT: 10:04:55 INFO - 2015-12-11 10:04:55,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60346/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:04:55 INFO - 2015-12-11 10:04:55,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 156286976 10:04:55 INFO - 2015-12-11 10:04:55,624 DEBUG : BROWSER_OUTPUT: 10:04:58 INFO - 2015-12-11 10:04:58,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60346/tests/kraken/driver.html?testName=imaging-darkroom) 10:04:59 INFO - 2015-12-11 10:04:59,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 157868032 10:04:59 INFO - 2015-12-11 10:04:59,230 DEBUG : BROWSER_OUTPUT: 10:05:02 INFO - 2015-12-11 10:05:02,655 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60346/tests/kraken/driver.html?testName=imaging-desaturate) 10:05:03 INFO - 2015-12-11 10:05:03,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 158846976 10:05:03 INFO - 2015-12-11 10:05:03,237 DEBUG : BROWSER_OUTPUT: 10:05:06 INFO - 2015-12-11 10:05:06,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60346/tests/kraken/driver.html?testName=json-parse-financial) 10:05:06 INFO - 2015-12-11 10:05:06,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 159006720 10:05:06 INFO - 2015-12-11 10:05:06,669 DEBUG : BROWSER_OUTPUT: 10:05:08 INFO - 2015-12-11 10:05:08,443 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60346/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:05:09 INFO - 2015-12-11 10:05:09,009 DEBUG : BROWSER_OUTPUT: RSS: Main: 166121472 10:05:09 INFO - 2015-12-11 10:05:09,009 DEBUG : BROWSER_OUTPUT: 10:05:10 INFO - 2015-12-11 10:05:10,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:05:11 INFO - 2015-12-11 10:05:11,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 166363136 10:05:11 INFO - 2015-12-11 10:05:11,475 DEBUG : BROWSER_OUTPUT: 10:05:13 INFO - 2015-12-11 10:05:13,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:05:14 INFO - 2015-12-11 10:05:14,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 174456832 10:05:14 INFO - 2015-12-11 10:05:14,168 DEBUG : BROWSER_OUTPUT: 10:05:16 INFO - 2015-12-11 10:05:16,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:05:17 INFO - 2015-12-11 10:05:17,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 183902208 10:05:17 INFO - 2015-12-11 10:05:17,309 DEBUG : BROWSER_OUTPUT: 10:05:19 INFO - 2015-12-11 10:05:19,909 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:05:20 INFO - 2015-12-11 10:05:20,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 179929088 10:05:20 INFO - 2015-12-11 10:05:20,491 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60346/tests/kraken/driver.html?testName=ai-astar) 10:05:22 INFO - 2015-12-11 10:05:22,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 238071808 10:05:22 INFO - 2015-12-11 10:05:22,519 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,519 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:05:22 INFO - 2015-12-11 10:05:22,519 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:05:22 INFO - 2015-12-11 10:05:22,519 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:05:22 INFO - 2015-12-11 10:05:22,519 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:05:22 INFO - 2015-12-11 10:05:22,519 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;105;111;111;113;102;112;111;111 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;138;163;167;139;153;155;132;175;130 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;160;160;159;161;161;161;161 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;73;89;93;72;73;72;102;93;71 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;132;94;95;94;145;95;95;131 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;109;109;109;110;109;110;110;109 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;146;146;146;146;146;146;146;145 10:05:22 INFO - 2015-12-11 10:05:22,520 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;96;95;95;95;95;95;95 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;70;71;70;70;71;71;80;69;69 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;69;69;69;68 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;82;83;85;83;84;83;84;84 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;126;126;123;123;120;127;128;126;118 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;137;152;149;145;138;153;150;137;139 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;71;70;69;67;68;68;67;69;69 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:05:22 INFO - 2015-12-11 10:05:22,521 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:05:22 INFO - 2015-12-11 10:05:22,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1011 10:05:22 INFO - 2015-12-11 10:05:22,522 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:05:22 INFO - 2015-12-11 10:05:22,522 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857122514__endTimestamp 10:05:22 INFO - 2015-12-11 10:05:22,522 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,523 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:05:22 INFO - 2015-12-11 10:05:22,523 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.49 (3.1%) stddev-sans-first:3.70 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 105.0 111.0 111.0 113.0 102.0 112.0 111.0 111.0 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.50 Median:154.00 stddev:15.32 (9.9%) stddev-sans-first:16.22 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: Values: 153.0 138.0 163.0 167.0 139.0 153.0 155.0 132.0 175.0 130.0 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.95 (0.6%) stddev-sans-first:0.88 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 160.0 160.0 159.0 161.0 161.0 161.0 161.0 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,524 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.90 Median:73.00 stddev:11.94 (16.4%) stddev-sans-first:12.11 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 89.0 93.0 72.0 73.0 72.0 102.0 93.0 71.0 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:95.00 stddev:20.28 (21.4%) stddev-sans-first:21.04 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 132.0 94.0 95.0 94.0 145.0 95.0 95.0 131.0 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:109.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 109.0 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 10:05:22 INFO - 2015-12-11 10:05:22,525 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.20 Median:71.00 stddev:3.19 (4.5%) stddev-sans-first:3.38 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 71.0 70.0 70.0 71.0 71.0 80.0 69.0 69.0 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.03 (1.2%) stddev-sans-first:1.00 10:05:22 INFO - 2015-12-11 10:05:22,526 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 82.0 83.0 85.0 83.0 84.0 83.0 84.0 84.0 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:126.00 stddev:3.18 (2.5%) stddev-sans-first:3.37 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: Values: 124.0 126.0 126.0 123.0 123.0 120.0 127.0 128.0 126.0 118.0 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.20 Median:147.00 stddev:6.41 (4.4%) stddev-sans-first:6.75 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: Values: 142.0 137.0 152.0 149.0 145.0 138.0 153.0 150.0 137.0 139.0 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:1.25 (1.8%) stddev-sans-first:1.32 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 70.0 69.0 67.0 68.0 68.0 67.0 69.0 69.0 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:05:22 INFO - 2015-12-11 10:05:22,527 DEBUG : BROWSER_OUTPUT: 10:05:23 INFO - 2015-12-11 10:05:23,372 INFO : Browser exited with error code: 0 10:05:23 INFO - 2015-12-11 10:05:23,425 INFO : Completed test kraken (00:01:00) 10:05:23 INFO - 2015-12-11 10:05:23,425 INFO : Starting test v8_7 10:05:23 INFO - 2015-12-11 10:05:23,425 DEBUG : operating with platform_type : linux_ 10:05:23 INFO - 2015-12-11 10:05:23,425 INFO : Initialising browser for v8_7 test... 10:05:23 INFO - 2015-12-11 10:05:23,431 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIvTDl/profile http://localhost:60346/getInfo.html 10:05:27 INFO - 2015-12-11 10:05:27,322 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:05:27 INFO - 2015-12-11 10:05:27,323 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:05:27 INFO - 2015-12-11 10:05:27,323 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:05:27 INFO - 2015-12-11 10:05:27,323 DEBUG : BROWSER_OUTPUT: __metrics 10:05:27 INFO - 2015-12-11 10:05:27,405 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] 10:05:27 INFO - 2015-12-11 10:05:27,466 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] 10:05:28 INFO - 2015-12-11 10:05:28,600 INFO : Browser initialized. 10:05:28 INFO - 2015-12-11 10:05:28,600 INFO : Running cycle 1/1 for v8_7 test... 10:05:28 INFO - 2015-12-11 10:05:28,600 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPIvTDl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:05:40 INFO - 2015-12-11 10:05:40,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 141471744 10:05:40 INFO - 2015-12-11 10:05:40,631 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,031 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60346/tests/v8_7/run.html (next: http://localhost:60346/tests/v8_7/run.html) 10:06:02 INFO - 2015-12-11 10:06:02,281 DEBUG : BROWSER_OUTPUT: RSS: Main: 443617280 10:06:02 INFO - 2015-12-11 10:06:02,281 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: |0;Richards;168.01075268817203 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.3238308179616 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.1641168289291 10:06:02 INFO - 2015-12-11 10:06:02,282 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 10:06:02 INFO - 2015-12-11 10:06:02,283 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 10:06:02 INFO - 2015-12-11 10:06:02,283 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 10:06:02 INFO - 2015-12-11 10:06:02,283 DEBUG : BROWSER_OUTPUT: |6;Boyer;11697.67441860465 10:06:02 INFO - 2015-12-11 10:06:02,283 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 10:06:02 INFO - 2015-12-11 10:06:02,283 DEBUG : BROWSER_OUTPUT: |8;Splay;614.2506142506143 10:06:02 INFO - 2015-12-11 10:06:02,284 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 10:06:02 INFO - 2015-12-11 10:06:02,284 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:06:02 INFO - 2015-12-11 10:06:02,284 DEBUG : BROWSER_OUTPUT: __startTimestamp1449857162280__endTimestamp 10:06:02 INFO - 2015-12-11 10:06:02,284 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,284 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:06:02 INFO - 2015-12-11 10:06:02,285 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:06:02 INFO - 2015-12-11 10:06:02,285 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,285 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.01 Median:168.01 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,285 DEBUG : BROWSER_OUTPUT: Values: 168.0 10:06:02 INFO - 2015-12-11 10:06:02,285 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,285 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.32 Median:186.32 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: Values: 186.3 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: Values: 278.2 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,286 DEBUG : BROWSER_OUTPUT: Values: 5191.7 10:06:02 INFO - 2015-12-11 10:06:02,287 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,287 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,287 DEBUG : BROWSER_OUTPUT: Values: 1972.4 10:06:02 INFO - 2015-12-11 10:06:02,287 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,287 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,288 DEBUG : BROWSER_OUTPUT: Values: 784.3 10:06:02 INFO - 2015-12-11 10:06:02,288 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,288 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11697.67 Median:11697.67 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,288 DEBUG : BROWSER_OUTPUT: Values: 11697.7 10:06:02 INFO - 2015-12-11 10:06:02,289 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,289 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,289 DEBUG : BROWSER_OUTPUT: Values: 26947.4 10:06:02 INFO - 2015-12-11 10:06:02,289 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,289 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.25 Median:614.25 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,290 DEBUG : BROWSER_OUTPUT: Values: 614.3 10:06:02 INFO - 2015-12-11 10:06:02,290 DEBUG : BROWSER_OUTPUT: 10:06:02 INFO - 2015-12-11 10:06:02,290 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 10:06:02 INFO - 2015-12-11 10:06:02,291 DEBUG : BROWSER_OUTPUT: Values: 4830.9 10:06:02 INFO - 2015-12-11 10:06:02,292 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:06:02 INFO - 2015-12-11 10:06:02,292 DEBUG : BROWSER_OUTPUT: 10:06:03 INFO - 2015-12-11 10:06:03,240 INFO : Browser exited with error code: 0 10:06:03 INFO - 2015-12-11 10:06:03,254 INFO : Completed test v8_7 (00:00:39) 10:06:03 INFO - 2015-12-11 10:06:03,330 INFO : Completed test suite (00:20:17) 10:06:03 INFO - 2015-12-11 10:06:03,330 DEBUG : Working with test: dromaeo_css 10:06:03 INFO - 2015-12-11 10:06:03,330 DEBUG : Generating results file: dromaeo_css 10:06:03 INFO - 2015-12-11 10:06:03,331 DEBUG : Working with test: kraken 10:06:03 INFO - 2015-12-11 10:06:03,331 DEBUG : Generating results file: kraken 10:06:03 INFO - 2015-12-11 10:06:03,332 INFO : javascript benchmark 10:06:03 INFO - 2015-12-11 10:06:03,332 DEBUG : Working with test: v8_7 10:06:03 INFO - 2015-12-11 10:06:03,332 DEBUG : Generating results file: v8_7 10:06:03 INFO - 2015-12-11 10:06:03,332 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:03 INFO - 2015-12-11 10:06:03,397 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 10:06:03 INFO - 2015-12-11 10:06:03,397 DEBUG : process_Request line: dromaeo_css 6185.70 graph.html#tests=[[72,132,35]] 10:06:03 INFO - 2015-12-11 10:06:03,397 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:03 INFO - 2015-12-11 10:06:03,429 DEBUG : process_Request line: kraken 1519.40 graph.html#tests=[[232,132,35]] 10:06:03 INFO - 2015-12-11 10:06:03,429 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:06:03 INFO - 2015-12-11 10:06:03,463 DEBUG : process_Request line: v8_7 19853.99 graph.html#tests=[[230,132,35]] 10:06:03 INFO - 2015-12-11 10:06:03,464 INFO : javascript benchmark 10:06:03 INFO - 2015-12-11 10:06:03,468 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2609.634651148839, 2710.728927107288, 2713.7150599187084, 2728.277006593252, 2737.8220415672986, 4378.56214378562, 4586.862394128173, 4642.698224615402, 4706.905861882765, 4711.411073615798, 4607.10161518504, 4608.331791890174, 4680.6957547759375, 4680.6957547759375, 4727.52724727527, 4298.935515967263, 4357.2592659248, 4366.214081465343, 4437.223485889973, 4442.244818380883, 4377.912441751163, 4410.0, 4442.267025940716, 4443.4445694288215, 4474.709143905652, 4176.123014167013, 4238.682098842568, 4293.527711951683, 4330.956690433087, 4356.215881141393, 4316.805743741539, 4319.697621166488, 4323.243432399349, 4349.565043495657, 4350.0647360817575, 4284.121755040209, 4285.5071666758095, 4301.397804307399, 4301.5698430157045, 4338.067315527177, 4375.278079116942, 4436.534163912775, 4446.177457170402, 4565.954340456587, 4698.295255711637, 5067.467915868854, 5078.568321692624, 5081.695098294114, 5088.0, 5098.515641014098, 5075.111855425286, 5075.847724568269, 5088.92366614501, 5130.333056702642, 5141.5886729061585, 4459.264221403497, 4562.954370456253, 4566.657500687462, 4673.556012178838, 4675.742834144121, 5215.348081489814, 5219.217117432339, 5221.947780522146, 5222.373315202124, 5255.921161182585, 4995.225740010304, 5003.399592048978, 5004.174311238678, 5008.348914641147, 5045.974770126126, 4920.532549407801, 4972.950270497248, 5046.091703493406, 5046.44489106198, 5105.055564720538, 5027.0, 5031.295618613324, 5032.521910418504, 5052.671576347526, 5060.898782024339, 5018.949810501848, 5021.372328458942, 5022.171341728574, 5022.899542009212, 5065.797368105234, 4062.1469491407133, 4121.855735049319, 4153.02403935075, 4156.459660244149, 4304.096139810675, 3727.6458736419995, 3742.7567208131386, 3770.7171962102952, 3776.5090538229856, 3776.6223377662013, 4229.471316085489, 4278.058827058042, 4281.464816897887, 4284.293091639907, 4320.675949303752, 5084.186530155157, 5089.312942752755, 5094.5669618082875, 5096.974515127401, 5100.285959965608, 4331.393604895317, 4338.7830608470085, 4343.391925130484, 4376.606105450524, 4380.167768124046, 4300.37644541546, 4361.0841723237845, 4405.427294451701, 4411.713238639478, 4511.323301504801, 4663.090697313991, 4733.408323959505, 4738.31294462308, 4744.240921452551, 4779.593734532604, 5025.949740502549, 5034.320366750442, 5070.543651071422, 5072.746362681925, 5073.949260507496, 4610.492845786894, 4664.323673067454, 4778.689385189951, 4809.495003024772, 4857.878553036202, 4862.562369386772, 4968.22992436173, 4970.0, 4971.502849715, 5010.448850626355, 5065.924011139909, 5138.254953031864, 5138.306328645585, 5142.357205349332, 5184.144616138446, 4768.403949506312, 4907.877303067452, 4955.256711493161, 4969.35398398206, 4974.850754477371, 4898.387701537308, 4907.214845624826, 4922.4339200992345, 4923.113839508923, 4924.606031517542, 4712.316714076508, 4780.808767649255, 4832.20268655682, 4836.854894353034, 4867.050925069578, 4957.132501812241, 4971.279164521196, 4972.975135124301, 4980.27785971025, 4998.2002879539095, 4856.1016212000895, 4861.538153875376, 4865.635077369282, 4870.099031679009, 4912.435069966999], "unit": "ms", "name": "dojo.html", "value": 4618.754129339359}, {"lowerIsBetter": false, "replicates": [566.7251383079208, 567.7615401531357, 578.50248786044, 580.0342429854293, 591.9171316015755, 26203.0, 26886.865565672168, 34849.65150348496, 35488.64511354885, 35576.2884742305, 39051.0, 39586.0, 39588.80205598968, 39600.80199599005, 39614.40578391319, 7689.730859419921, 7995.560244186568, 7996.800079997988, 8001.599920004006, 8002.479838810488, 7123.964380178118, 7307.2327405622445, 10148.188144948386, 10363.844542331872, 10376.53305601246, 9926.900730992706, 10088.747781305452, 10097.091261786438, 10109.443980581065, 10120.797584048314, 7103.396211322044, 7295.088113985752, 9934.65228716995, 10044.748881277954, 10050.09549140581, 9916.0, 10185.236107291908, 10188.59245630174, 10188.898111018869, 10191.541380637815, 35944.28111437757, 36353.63646363529, 36434.27131457356, 36481.0, 36611.4508282376, 2786.965515173914, 2839.2617919340914, 3017.909462716122, 3224.8548815303366, 3246.870125194989, 28314.575281370795, 28386.432271354664, 28646.0, 28874.855625721946, 28977.13068607945, 3262.559554460141, 3323.252268239651, 3382.0699307690584, 3383.9492407613907, 3397.0, 205021.0, 205336.0, 207803.0, 208158.0, 208900.0, 50635.24047139296, 52018.0, 54439.0, 54857.72571137198, 54923.72538137284, 58791.0, 59825.70087149536, 60008.699956499935, 60032.39967600268, 60138.097928531104, 11906.404679765978, 12063.879361206451, 12065.698357541132, 12073.335966521925, 12087.214331068453, 9010.819783604291, 9104.226140778108, 9107.362484626012, 9110.088991100836, 9115.81768364629, 18234.27062917495, 18435.631287374177, 19171.616567668567, 19247.807521924602, 19311.517212069528, 7708.961455192688, 7903.644336004893, 8012.1186669466315, 8065.596720163969, 8070.0, 766.107484780236, 797.3103265675265, 816.5998660656354, 925.9398139120935, 928.4661319741176, 25049.87475062613, 25076.373090672514, 25136.748632513805, 25220.149346919556, 25286.747132528806, 855.1363123245443, 906.7370462565782, 912.8402529557301, 922.294444749767, 923.385948344357, 12953.417096230693, 13417.249185303039, 13455.461781528826, 13497.730045399234, 13506.054576179573, 302725.0, 307199.0, 307645.0, 307961.0, 308483.0, 47288.76355618269, 47799.0, 47853.28220076702, 47868.5213147871, 47887.76056119697, 1166.8191430328313, 1172.5016867831137, 1204.1390405859852, 1218.9634310970685, 1235.1415766042514, 24404.51190976206, 25208.36979075538, 25503.872480637478, 25553.61669574995, 25574.0, 37361.4395784058, 37422.0, 37903.43144852885, 37911.62088379191, 37975.0, 245400.0, 247359.0, 247476.0, 247687.0, 247969.0, 24575.631365529174, 25044.874775626005, 28352.858235709515, 28915.0, 29312.267193319483, 32460.837695812315, 32539.674603253665, 44073.338899917166, 45452.77273613743, 45509.544904551854, 33044.339113217124, 33230.83384583062, 33550.66449335573, 33701.32597348088, 33922.49116263307, 29658.703412965595, 37322.0, 37538.436923445624, 38953.80523097367, 39260.0, 31956.0, 32051.67948320487, 32500.674993250712, 32689.0, 32956.0, 29265.858162399392, 30590.694093059676, 33485.0, 35713.64286357103, 35721.64278357287, 23199.420014499097, 23621.173258935854, 23810.0, 23975.160869369487, 23980.520389591762], "unit": "ms", "name": "ext.html", "value": 16994.801489416004}, {"lowerIsBetter": false, "replicates": [335.52020610526944, 336.78782367108704, 338.0585070578438, 338.60383351478765, 343.30994700651684, 12159.209651372677, 12545.874541254585, 15177.544673659793, 15229.314680839376, 15859.603509912244, 14818.184999825005, 15095.962045123904, 15376.846231537682, 15462.69074618507, 15580.922095389507, 4541.046380260149, 4777.856664300077, 4897.387826521676, 5001.249812528132, 5003.39959204896, 4938.703677779326, 4961.875953101166, 4970.627202959774, 4974.850754477354, 4976.601871850261, 4926.926096108561, 5032.82385116521, 5044.848654540369, 5052.292679024939, 5114.641975061747, 4982.352294201767, 5010.599152067844, 5022.472640372781, 5035.269885866529, 5041.294218809369, 4373.803178856927, 4490.3488994096, 4492.393526873863, 4495.056038231975, 4523.547645235483, 19356.903215483973, 19432.22271109154, 19437.708434373497, 19663.508412289808, 19857.304994325274, 1863.4689113602558, 1886.6981282994793, 1957.8923159226238, 1982.226931496703, 1989.980100198994, 8370.8325833483, 8635.481871087692, 8779.517126558037, 9048.457092574467, 13035.674108147277, 1712.0, 1720.1399300349824, 1722.285251620576, 1722.7329763886617, 1758.832910873465, 54130.729346353015, 55100.17349739797, 55292.72353638206, 55670.44329556693, 55691.44308556903, 9742.0, 9823.705288841204, 9823.901760982299, 9857.570652255527, 9867.555959981819, 10341.37951722884, 10584.364938103738, 11891.405429728478, 12323.0, 12351.814722779165, 6420.871582568416, 6547.377999090078, 6561.343865613496, 6603.504737144734, 6607.537472376887, 6072.666003369857, 6075.058365953284, 6153.446189842935, 6177.567570270128, 6241.313455519889, 4077.4699289092227, 4083.3262511685834, 4104.774237416911, 4120.505539335239, 4121.814518346621, 1677.8909370890854, 1718.5703574106474, 1724.3533674871924, 1736.6266252755465, 1739.7651317072286, 394.2784703991746, 724.4135343597504, 786.7757689058706, 913.4291068082448, 977.2914636888199, 9409.388389754644, 9609.711708648752, 9630.903690963141, 9957.402555846527, 9971.252156088321, 368.48596208289285, 388.5337594886091, 388.5628667748783, 413.85928784213513, 427.50623030399936, 4629.2824612184495, 5484.369297530835, 5555.0, 5594.552435805126, 8946.418482798597, 328671.20979555976, 383110.0, 510406.0, 511815.0, 520279.0, 55847.0, 70122.0, 73604.0, 76518.61740691261, 76917.61541192258, 995.7958618483339, 1032.4631191780231, 1034.5448002878709, 1041.770810421706, 1064.0955188090215, 14444.133351998493, 14690.63273418173, 14759.778603320745, 14763.335649895995, 14869.256537173314, 30623.387532249675, 31011.84494077515, 31012.0, 31814.363712725153, 32269.838650806596, 41922.0, 42052.36921446242, 42601.36097958595, 42633.0, 43379.349309759746, 8501.234888860032, 8826.735197944072, 8911.821763564822, 8978.820423591622, 9114.0, 14119.929400352932, 15838.049717017017, 15914.124723139876, 16063.839361606235, 17047.65904681924, 13264.0, 13272.27002514871, 13519.662008449868, 14081.225532595805, 14685.19231442281, 13650.0, 13727.656808579866, 13833.446662133401, 13917.304134793018, 14017.439302427789, 13787.310634468036, 13840.584782456543, 13996.930015349859, 14215.50245741394, 14539.200343981183, 9044.321675874204, 9075.092490750872, 9075.092490751136, 9103.772405689646, 9227.815443690954, 13009.804852927024, 13080.672983175496, 13133.015023873057, 13328.800067998794, 13863.37614807316], "unit": "ms", "name": "jquery.html", "value": 7773.3526881886455}, {"lowerIsBetter": false, "replicates": [1202.9939850300748, 1634.5014770494997, 1661.6925868714288, 1684.8736344774145, 1718.3642052440596, 5751.8274451766465, 6771.052052712618, 6955.791326260208, 6962.0601218835445, 6970.0938877945855, 6682.532222744409, 6841.657917104138, 6871.4846386521085, 6871.587704737719, 6874.79375618731, 1741.3208848549075, 1767.3195819609414, 1771.6633839570504, 2045.5193029638024, 2091.801278878504, 1760.2255007796593, 1769.1419661464179, 1999.6300684373364, 2068.25542804591, 2068.8758674479577, 2012.5069358007308, 2023.1806118522022, 2032.7357443532394, 2035.2673037706413, 2036.6435873722114, 2089.237428338653, 2113.2286715348787, 2117.830573554112, 2118.947026324339, 2118.9934780979065, 2047.5393036566802, 2064.9380518584467, 2068.162394230339, 2068.4415207893785, 2096.926607568728, 6964.129483814523, 7022.508424410294, 7029.683664235122, 7032.331928466839, 7059.188193357778, 4086.652634526069, 4146.170765846843, 4147.6474499667565, 4152.958470415288, 4154.5222299435645, 2694.8383097014244, 2697.0560303893676, 2732.0164740693335, 2743.917682469529, 2757.6828664703617, 825.9958700206521, 836.0970152235572, 839.1524560194187, 841.2512863551444, 860.4192170285032, 9351.064893510595, 9376.95311523438, 9379.0, 9379.76550586234, 9380.90619093807, 3857.2478366718783, 3925.7644541327613, 3931.4889064422014, 3948.58539853317, 3973.304671682502, 8046.275835174745, 8070.47541909774, 8085.514869107872, 8086.150954149847, 8097.919020809834, 4087.795610219477, 4114.526829414595, 4115.115250221217, 4133.731307465006, 4139.97930010348, 3758.6429289218026, 3759.2105657812167, 3762.4544441055896, 3767.6420740029653, 3769.7738135711943, 2923.0500087471655, 3293.884714034997, 3342.8161451120422, 3370.6966373026544, 3371.662833716609, 944.3153713557616, 1007.5868893753526, 1048.491481631408, 1052.1267348101057, 1065.2862582070031, 888.6889588643922, 907.3240435875183, 915.3135148638521, 916.2898753465984, 1051.279873286801, 6406.327335629785, 6479.902801457982, 6491.188601424822, 6498.740050398026, 6515.218173819172, 1006.1699098243978, 1012.4836333469983, 1021.6349151713907, 1025.4411345816548, 1043.5929987304958, 4915.188993816052, 4918.163912134945, 4964.429090654548, 4966.230234313687, 4977.9751101244265, 7717.65270562826, 7889.723859664884, 7926.841463170705, 7932.762017139495, 8056.637451314705, 7766.9611651942505, 7820.139784623687, 7838.255365740246, 7838.294553490099, 7846.136924938252, 6346.619202847844, 6515.641639709862, 6552.410283074546, 6640.966795165993, 6678.866422671519, 6710.6309152997055, 6747.156605424322, 6779.93220067793, 6800.727970881109, 6804.285550017177, 7375.151857536237, 7554.169041405551, 7583.393328533593, 7653.57905315213, 7654.655540500579, 7631.0, 7825.569593672402, 7829.765107046797, 7842.725504607311, 7843.215678432111, 6174.0, 6226.377362263737, 6227.159333490102, 6240.719167637558, 6245.094461302995, 5389.164679474688, 6376.043593461018, 6485.0, 6565.113709649328, 6567.310432404529, 5585.357683866408, 6090.451859332681, 6125.356837531995, 6133.9079913802225, 6318.399752023551, 6043.607165534227, 6091.299500557316, 6119.4798442132915, 6201.534884883562, 6239.438450539473, 6208.0, 6264.5301602379095, 6275.874482510416, 6286.9626511625065, 6289.465395441256, 5645.661260324394, 5663.830085097454, 5746.109353050284, 5758.884822303614, 5767.307923049261, 5958.314793798769, 5968.492678122235, 5994.400559943971, 5996.130561068708, 6011.549133815069], "unit": "ms", "name": "mootools.html", "value": 3972.3483101345837}, {"lowerIsBetter": false, "replicates": [306.15959192017914, 310.42261393807513, 313.0467725775015, 314.89471953443405, 316.85583059707835, 5269.209618557218, 5356.705381204037, 5365.195220716884, 5366.677999320043, 5371.167469042295, 5204.9219261711105, 5245.160774276116, 5246.711430871301, 5255.789768409259, 5276.472352764722, 3902.5512066112333, 4009.719319647626, 4149.771762553059, 4157.272477316473, 4160.521540022898, 4034.0519977805193, 4119.320312148492, 4140.668746500272, 4169.270377683908, 4182.64447521961, 4111.075008123164, 4123.237201117803, 4125.133721918401, 4134.0, 4143.02638879863, 3874.651281384689, 3966.226585815767, 3991.5409727881374, 4125.566815484391, 4136.875893723178, 3616.276744651054, 3625.274945010982, 3648.4709717090873, 3649.543807024122, 3656.634336566349, 5075.111855425286, 5076.873078173038, 5077.669951453181, 5078.0, 5099.107656160157, 4741.976290118528, 4755.833545825914, 4756.405449318835, 4757.26262429324, 4758.3576217210575, 5457.590680698924, 5578.3584887738025, 5587.469190426903, 5591.552675785927, 5601.831945041656, 3947.8618248361167, 3985.720999530034, 3990.38149086892, 3991.98004009981, 4000.5399379071487, 5843.5033022193165, 5847.26909136358, 5852.092925596539, 5856.882862342729, 5860.17957485948, 4083.959160408358, 4110.527289361762, 4112.547619761824, 4112.753234805921, 4117.75293482392, 4069.552349241581, 4157.833686652561, 4171.666266698657, 4184.995601055785, 4187.413762073312, 4700.7179569225955, 4708.081924024782, 4712.929306060412, 4712.929306060412, 4717.646176536773, 5556.91664625031, 5562.582806289544, 5564.137558678412, 5564.666120032811, 5567.053600887859, 1453.7237924794467, 1467.207707837777, 1469.0524611625656, 1469.0965056490395, 1470.9043912145676, 1013.2147585621202, 1015.2030655935056, 1018.332991890313, 1037.3827572594294, 1037.5331101004579, 4870.6103511718975, 4871.464138944713, 4871.537203965618, 4872.0, 4874.902501949941, 5719.771209151588, 5752.798652047242, 5759.913601295984, 5765.221695071112, 5767.5674324425, 4833.468318484964, 4849.636277279147, 4854.635902307341, 4864.951350486521, 4866.902661946741, 3020.411019851152, 3061.6938306169204, 3110.0, 3111.284404586958, 3112.64204616472, 5429.864253393696, 5500.724963751796, 5502.0371434998715, 5507.0637991541535, 5518.751656175482, 6028.246469191351, 6031.788887388921, 6032.4570788629235, 6033.78881739137, 6037.698115094227, 5496.587755918402, 5517.531009864127, 5518.558515318765, 5522.585806064561, 5523.364813046471, 5678.858028549319, 5797.768089276382, 5847.561432892465, 5849.590528662953, 5853.590248682722, 5677.659340439587, 5699.458551437607, 5704.914426283692, 5706.828795136153, 5711.657300561979, 5411.377691565521, 5470.480304371078, 5476.753546090516, 5485.424030476743, 5490.313710786152, 3874.2832575973534, 3966.6826653868197, 4004.8197831097086, 4004.979975100106, 4049.1901619675596, 5789.884202316014, 5793.15999180125, 5795.304563452412, 5795.710214489174, 5804.361520232686, 5570.554355651457, 5579.888402231852, 5583.274174357308, 5584.134459158837, 5585.5531557476115, 5566.109422492544, 5570.5265052470995, 5574.191742197278, 5578.665280083208, 5587.888242235052, 5303.0, 5494.972525137348, 5512.310961129859, 5512.3385193777, 5520.06158952971, 5392.514673679388, 5567.55459563242, 5643.1535269709875, 5651.350094738993, 5669.858253543694, 5405.702686352289, 5516.648421136847, 5538.695371754431, 5552.7223638818705, 5553.361363443256], "unit": "ms", "name": "prototype.html", "value": 4216.37554992615}, {"lowerIsBetter": false, "replicates": [677.7661706711183, 722.0324764815147, 744.8249661329584, 755.2372104174783, 770.3567521119863, 10532.368057916521, 10608.840867386976, 10639.468026598668, 10670.466476676174, 10679.199060070496, 11085.390303533302, 11291.830622540649, 11334.093272538197, 11368.09055275578, 11373.601923932663, 758.8823732321486, 779.364817673597, 779.4699604269094, 780.3873958942231, 780.6057940739947, 763.2520130272336, 771.2827070824131, 774.4114473000504, 775.0931410250021, 775.5036776463069, 801.8155824160417, 810.1776696652902, 810.5906517208801, 811.2090711556215, 811.407672399146, 811.2131232704268, 812.4800127918137, 812.7846120777998, 813.2883726739103, 813.3899575318511, 600.1747597054051, 600.9729562169713, 601.0833478944601, 601.1613798750718, 601.3595520770366, 10110.64612738558, 10165.0, 10174.236932230113, 10189.184865210766, 10210.693679189637, 8847.77880552985, 9587.280953928414, 9669.806603867883, 9725.610975560969, 9931.205503559699, 7954.522728636301, 8124.796880077986, 8169.30560902324, 8250.793730156734, 8304.418690691655, 3121.0480803354967, 3209.5988001499813, 3223.9355212895844, 3226.9677303226904, 3239.3683231769814, 31455.52816707751, 35389.823050884836, 38269.61730382688, 43313.78343108296, 43375.78312108419, 9209.631614735335, 9299.581518831668, 9305.953470232605, 9402.529873506297, 9580.0898914603, 16485.83514164867, 16504.42234521786, 16594.336226550804, 16638.75041874373, 16648.417305394254, 6041.395860413923, 6068.302145253264, 6087.1173679816175, 6137.324894261627, 6145.293291271471, 3497.3355062538544, 3515.7538972271695, 3577.94633080504, 3589.515415418937, 3641.1807343348064, 2669.7196794336705, 2679.142674344191, 2685.3018215264174, 2686.2478506018347, 2686.7984901132104, 462.5305315105171, 463.10851610650036, 465.6531083339996, 472.37410431178824, 473.43424607593596, 424.27449062103534, 491.43730428658984, 503.39843886555946, 542.2002546244337, 544.4256309593417, 7055.823604409931, 7108.857822843514, 7408.814779630445, 7651.5409075455655, 7752.224777522202, 515.5025400488472, 521.4628932199764, 521.6531006880382, 544.7303584725586, 555.0397811785552, 3397.456406974872, 3701.7964011979598, 3706.40478735626, 3747.7001839852746, 3760.981195094007, 41169.17661646751, 41173.38239926403, 41483.1703365937, 41688.58311416847, 44028.3395749064, 34557.0, 37847.0, 39675.0, 41619.37570936439, 41719.1656166881, 37539.81230093832, 37864.62135378611, 38005.61994380076, 38719.80640096838, 39500.604993950845, 7778.611069446391, 8056.36680070814, 8093.554854482824, 8285.047219569826, 8289.461185022954, 29823.0, 29855.0, 30051.84974075203, 30391.39217215599, 31698.366032679678, 37964.810175948944, 38390.23219535538, 38399.42400863933, 38529.22941541098, 38831.0, 9166.770830729285, 9842.415529832255, 10011.048950349705, 10227.795444091225, 10232.693019209435, 10550.143779663786, 10701.411422371533, 10733.27414737314, 10948.124150068135, 10976.560937562408, 10665.253432259668, 10703.464826758787, 10758.354498730101, 10844.132469402586, 11057.834132487858, 10464.895351046393, 10612.28545170018, 10760.569577216824, 10924.781504369708, 11074.5570177192, 9304.30217733659, 9328.860067098864, 9483.193928516153, 9611.567479463301, 9626.66306679291, 9339.112784285482, 9358.204552612831, 9526.476043817656, 9784.608615655294, 9964.800703985735, 9302.0, 9483.8635672213, 9486.478243696387, 9508.619655213713, 9592.66425675098], "unit": "ms", "name": "yui.html", "value": 5480.865969733854}], "name": "dromaeo_css", "value": 6185.694622095582}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 111.0, 111.0, 113.0, 102.0, 112.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [153.0, 138.0, 163.0, 167.0, 139.0, 153.0, 155.0, 132.0, 175.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 160.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 89.0, 93.0, 72.0, 73.0, 72.0, 102.0, 93.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 132.0, 94.0, 95.0, 94.0, 145.0, 95.0, 95.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 70.0, 70.0, 71.0, 71.0, 80.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 82.0, 83.0, 85.0, 83.0, 84.0, 83.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [124.0, 126.0, 126.0, 123.0, 123.0, 120.0, 127.0, 128.0, 126.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [142.0, 137.0, 152.0, 149.0, 145.0, 138.0, 153.0, 150.0, 137.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.2}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 69.0, 67.0, 68.0, 68.0, 67.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken", "value": 1519.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.01075268817203], "unit": "score", "name": "Richards", "value": 210.11750400000008}, {"lowerIsBetter": false, "replicates": [186.3238308179616], "unit": "score", "name": "DeltaBlue", "value": 354.85530600000016}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [11697.67441860465], "unit": "score", "name": "Boyer", "value": 56.97397415506962}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [614.2506142506143], "unit": "score", "name": "Splay", "value": 132.66734799999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19853.994941903497}]} 10:06:03 INFO - RETURN: dromaeo_css: 6185.70 10:06:03 INFO - RETURN: kraken: 1519.40 10:06:03 INFO - RETURN: v8_7: 19853.99 10:06:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19853.99"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1519.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6185.70"}}} 10:06:03 INFO - Return code: 0 10:06:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:06:03 INFO - # TBPL SUCCESS # 10:06:03 INFO - Running post-action listener: _resource_record_post_action 10:06:03 INFO - Running post-run listener: _resource_record_post_run 10:06:04 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 519421952; Read time: 12; Write time: 504564 10:06:04 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 243126272; Read time: 0; Write time: 332812 10:06:04 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276295680; Read time: 12; Write time: 171752 10:06:04 INFO - Running post-run listener: _upload_blobber_files 10:06:04 INFO - Blob upload gear active. 10:06:04 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:06:04 INFO - Copying logs to upload dir... 10:06:04 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.660578 ========= master_lag: 0.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-11 10:06:04.833769) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:06:04.837672) ========= 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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009254 build_url: 'https://queue.taskcluster.net/v1/task/tD6mxPqYR3-FsVPMaIY0Vw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:06:04.861397) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:06:04.861727) ========= 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=21869f6c619b95355032545b000001da-1449855475.259692-441896371 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:06:04.911172) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:06:04.911519) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 10:06:04.911799) ========= ========= Total master_lag: 0.71 =========