builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1450107397.52 results: success (0) buildid: 20151214064931 builduid: bc7c31b0f0e040d3a9477eba00d72e9e revision: a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.517197) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.517661) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.518329) ========= 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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006302 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.546001) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.546285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.562196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.562470) ========= 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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004616 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.613162) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.613461) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.613832) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.614156) ========= 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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-14 07:36:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.9M=0.001s 2015-12-14 07:36:37 (21.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.797001) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.797351) ========= 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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.846605) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:37.846956) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 --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 a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 --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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-14 07:36:38,086 truncating revision to first 12 chars 2015-12-14 07:36:38,086 Setting DEBUG logging. 2015-12-14 07:36:38,086 attempt 1/10 2015-12-14 07:36:38,086 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a5a1cf9c5a9e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-14 07:36:38,319 unpacking tar archive at: fx-team-a5a1cf9c5a9e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.509327 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:38.372572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:38.372852) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:38.629954) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:38.630356) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-14 07:36:38.630836) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-14 07:36:38.631136) ========= /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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:38 INFO - MultiFileLogger online at 20151214 07:36:38 in /builds/slave/test 07:36:38 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 07:36:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:38 INFO - {'append_to_log': False, 07:36:38 INFO - 'base_work_dir': '/builds/slave/test', 07:36:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:36:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:38 INFO - 'branch': 'Fx-Team-Non-PGO', 07:36:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:38 INFO - 'config_files': ('talos/linux_config.py',), 07:36:38 INFO - 'default_actions': ('clobber', 07:36:38 INFO - 'read-buildbot-config', 07:36:38 INFO - 'download-and-extract', 07:36:38 INFO - 'populate-webroot', 07:36:38 INFO - 'create-virtualenv', 07:36:38 INFO - 'install', 07:36:38 INFO - 'run-tests'), 07:36:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:38 INFO - 'download_minidump_stackwalk': True, 07:36:38 INFO - 'download_symbols': 'ondemand', 07:36:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:38 INFO - 'installer_path': 'installer.exe', 07:36:38 INFO - 'log_level': 'info', 07:36:38 INFO - 'log_name': 'talos', 07:36:38 INFO - 'log_to_console': True, 07:36:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:38 INFO - 'opt_config_files': (), 07:36:38 INFO - 'pip_index': False, 07:36:38 INFO - 'sps_profile': False, 07:36:38 INFO - 'sps_profile_interval': 0, 07:36:38 INFO - 'suite': 'dromaeojs', 07:36:38 INFO - 'system_bits': '64', 07:36:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:38 INFO - 'title': 'talos-linux64-ix-045', 07:36:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:38 INFO - 'use_talos_json': True, 07:36:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:38 INFO - 'work_dir': 'build'} 07:36:38 INFO - ##### 07:36:38 INFO - ##### Running clobber step. 07:36:38 INFO - ##### 07:36:38 INFO - Running pre-action listener: _resource_record_pre_action 07:36:38 INFO - Running main action method: clobber 07:36:38 INFO - rmtree: /builds/slave/test/build 07:36:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:39 INFO - Running post-action listener: _resource_record_post_action 07:36:39 INFO - ##### 07:36:39 INFO - ##### Running read-buildbot-config step. 07:36:39 INFO - ##### 07:36:39 INFO - Running pre-action listener: _resource_record_pre_action 07:36:39 INFO - Running main action method: read_buildbot_config 07:36:39 INFO - Using buildbot properties: 07:36:39 INFO - { 07:36:39 INFO - "properties": { 07:36:39 INFO - "buildnumber": 2208, 07:36:39 INFO - "product": "firefox", 07:36:39 INFO - "script_repo_revision": "production", 07:36:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:36:39 INFO - "repository": "", 07:36:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:36:39 INFO - "buildid": "20151214064931", 07:36:39 INFO - "slavename": "talos-linux64-ix-045", 07:36:39 INFO - "pgo_build": "False", 07:36:39 INFO - "basedir": "/builds/slave/test", 07:36:39 INFO - "project": "", 07:36:39 INFO - "platform": "ubuntu64_hw", 07:36:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:36:39 INFO - "slavebuilddir": "test", 07:36:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:36:39 INFO - "branch": "fx-team", 07:36:39 INFO - "repo_path": "integration/fx-team", 07:36:39 INFO - "stage_platform": "linux64", 07:36:39 INFO - "builduid": "bc7c31b0f0e040d3a9477eba00d72e9e", 07:36:39 INFO - "revision": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69" 07:36:39 INFO - }, 07:36:39 INFO - "sourcestamp": { 07:36:39 INFO - "repository": "", 07:36:39 INFO - "hasPatch": false, 07:36:39 INFO - "project": "", 07:36:39 INFO - "branch": "fx-team-linux64-talos", 07:36:39 INFO - "changes": [ 07:36:39 INFO - { 07:36:39 INFO - "category": null, 07:36:39 INFO - "files": [ 07:36:39 INFO - { 07:36:39 INFO - "url": null, 07:36:39 INFO - "name": "https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:36:39 INFO - } 07:36:39 INFO - ], 07:36:39 INFO - "repository": "", 07:36:39 INFO - "rev": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69", 07:36:39 INFO - "who": "cbook@mozilla.com", 07:36:39 INFO - "when": 1450107379, 07:36:39 INFO - "number": 7357373, 07:36:39 INFO - "comments": "Bug 1231003 - clarify in variable names and comments that temporary add-ons can be files or dirs r=mossop", 07:36:39 INFO - "project": "", 07:36:39 INFO - "at": "Mon 14 Dec 2015 07:36:19", 07:36:39 INFO - "branch": "fx-team-linux64-talos", 07:36:39 INFO - "revlink": "", 07:36:39 INFO - "properties": [ 07:36:39 INFO - [ 07:36:39 INFO - "buildid", 07:36:39 INFO - "20151214064931", 07:36:39 INFO - "Change" 07:36:39 INFO - ], 07:36:39 INFO - [ 07:36:39 INFO - "builduid", 07:36:39 INFO - "bc7c31b0f0e040d3a9477eba00d72e9e", 07:36:39 INFO - "Change" 07:36:39 INFO - ], 07:36:39 INFO - [ 07:36:39 INFO - "pgo_build", 07:36:39 INFO - "False", 07:36:39 INFO - "Change" 07:36:39 INFO - ] 07:36:39 INFO - ], 07:36:39 INFO - "revision": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69" 07:36:39 INFO - } 07:36:39 INFO - ], 07:36:39 INFO - "revision": "a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69" 07:36:39 INFO - } 07:36:39 INFO - } 07:36:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:36:39 INFO - Running post-action listener: _resource_record_post_action 07:36:39 INFO - ##### 07:36:39 INFO - ##### Running download-and-extract step. 07:36:39 INFO - ##### 07:36:39 INFO - Running pre-action listener: _resource_record_pre_action 07:36:39 INFO - Running main action method: download_and_extract 07:36:39 INFO - mkdir: /builds/slave/test/build/tests 07:36:39 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')]} 07:36:39 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json 07:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json 07:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:36:43 INFO - Downloaded 1302 bytes. 07:36:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:36:43 INFO - Using the following test package requirements: 07:36:43 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:43 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:43 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'jsshell-linux-x86_64.zip'], 07:36:43 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:43 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:43 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:43 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:43 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:43 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:43 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:43 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:43 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:43 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:45 INFO - Downloaded 21869925 bytes. 07:36:45 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 07:36:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:45 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 07:36:46 INFO - Return code: 0 07:36:46 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 07:36:46 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')]} 07:36:46 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:36:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:47 INFO - Downloaded 21869925 bytes. 07:36:47 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 07:36:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:36:47 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 07:36:48 INFO - Return code: 0 07:36:48 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')]} 07:36:48 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:36:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:49 INFO - Downloaded 11132038 bytes. 07:36:49 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 07:36:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:49 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 07:36:49 INFO - Return code: 0 07:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:49 INFO - https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:36:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Vr_4ugPARkOEIyIwWLVwng/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 07:36:53 INFO - Downloaded 57745158 bytes. 07:36:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:53 INFO - mkdir: /builds/slave/test/properties 07:36:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:53 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:53 INFO - Contents: 07:36:53 INFO - build_url:https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:36:53 INFO - Running post-action listener: _resource_record_post_action 07:36:53 INFO - Running post-action listener: set_extra_try_arguments 07:36:53 INFO - ##### 07:36:53 INFO - ##### Running populate-webroot step. 07:36:53 INFO - ##### 07:36:53 INFO - Running pre-action listener: _resource_record_pre_action 07:36:53 INFO - Running main action method: populate_webroot 07:36:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:53 INFO - '--tppagecycles', 07:36:53 INFO - '7'], 07:36:53 INFO - 'tests': ['tsvgm']}}, 07:36:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:36:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:36:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:36:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'tests': ['damp', 'tps']}, 07:36:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['damp', 'tps']}, 07:36:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:36:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:53 INFO - 'other': {'tests': ['a11yr', 07:36:53 INFO - 'ts_paint', 07:36:53 INFO - 'tpaint', 07:36:53 INFO - 'sessionrestore', 07:36:53 INFO - 'sessionrestore_no_auto_restore']}, 07:36:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['a11yr', 07:36:53 INFO - 'ts_paint', 07:36:53 INFO - 'tpaint', 07:36:53 INFO - 'sessionrestore', 07:36:53 INFO - 'sessionrestore_no_auto_restore']}, 07:36:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['a11yr', 07:36:53 INFO - 'ts_paint', 07:36:53 INFO - 'tpaint', 07:36:53 INFO - 'sessionrestore', 07:36:53 INFO - 'sessionrestore_no_auto_restore']}, 07:36:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['a11yr', 07:36:53 INFO - 'ts_paint', 07:36:53 INFO - 'tpaint', 07:36:53 INFO - 'sessionrestore', 07:36:53 INFO - 'sessionrestore_no_auto_restore']}, 07:36:53 INFO - 'other_l64': {'tests': ['a11yr', 07:36:53 INFO - 'ts_paint', 07:36:53 INFO - 'tpaint', 07:36:53 INFO - 'sessionrestore', 07:36:53 INFO - 'sessionrestore_no_auto_restore']}, 07:36:53 INFO - 'other_nol64': {'tests': ['a11yr', 07:36:53 INFO - 'ts_paint', 07:36:53 INFO - 'tpaint', 07:36:53 INFO - 'sessionrestore', 07:36:53 INFO - 'sessionrestore_no_auto_restore']}, 07:36:53 INFO - 'svgr': {'tests': ['tsvgx', 07:36:53 INFO - 'tsvgr_opacity', 07:36:53 INFO - 'tart', 07:36:53 INFO - 'tscrollx', 07:36:53 INFO - 'cart']}, 07:36:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['tsvgx', 07:36:53 INFO - 'tsvgr_opacity', 07:36:53 INFO - 'tart', 07:36:53 INFO - 'tscrollx', 07:36:53 INFO - 'cart']}, 07:36:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'tests': ['tp5o']}, 07:36:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'talos_options': ['--e10s'], 07:36:53 INFO - 'tests': ['tp5o']}, 07:36:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'talos_options': ['--xperf_path', 07:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:53 INFO - 'tests': ['tp5n']}, 07:36:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:36:53 INFO - 'talos_options': ['--e10s', 07:36:53 INFO - '--xperf_path', 07:36:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:53 INFO - 'tests': ['tp5n']}}, 07:36:53 INFO - 'talos.zip': {'path': '', 07:36:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:53 INFO - Running post-action listener: _resource_record_post_action 07:36:53 INFO - ##### 07:36:53 INFO - ##### Running create-virtualenv step. 07:36:53 INFO - ##### 07:36:53 INFO - Running pre-action listener: _resource_record_pre_action 07:36:53 INFO - Running main action method: create_virtualenv 07:36:53 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:53 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 07:36:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:53 INFO - Using real prefix '/usr' 07:36:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:55 INFO - Installing pip.................done. 07:36:55 INFO - Return code: 0 07:36:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:55 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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:36:55 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 07:36:55 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 07:36:55 INFO - Using env: {'DISPLAY': ':0', 07:36:55 INFO - 'HOME': '/home/cltbld', 07:36:55 INFO - 'LANG': 'en_US.UTF-8', 07:36:55 INFO - 'LANGUAGE': 'en_US:en', 07:36:55 INFO - 'LOGNAME': 'cltbld', 07:36:55 INFO - 'MAIL': '/var/mail/cltbld', 07:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:55 INFO - 'MOZ_NO_REMOTE': '1', 07:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:55 INFO - 'NO_EM_RESTART': '1', 07:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:55 INFO - 'PWD': '/builds/slave/test', 07:36:55 INFO - 'SHELL': '/bin/bash', 07:36:55 INFO - 'SHLVL': '1', 07:36:55 INFO - 'TERM': 'linux', 07:36:55 INFO - 'TMOUT': '86400', 07:36:55 INFO - 'USER': 'cltbld', 07:36:55 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:55 INFO - '_': '/tools/buildbot/bin/python'} 07:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:55 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 07:36:55 INFO - Cleaning up... 07:36:55 INFO - Return code: 0 07:36:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:55 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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:36:55 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 07:36:55 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 07:36:55 INFO - Using env: {'DISPLAY': ':0', 07:36:55 INFO - 'HOME': '/home/cltbld', 07:36:55 INFO - 'LANG': 'en_US.UTF-8', 07:36:55 INFO - 'LANGUAGE': 'en_US:en', 07:36:55 INFO - 'LOGNAME': 'cltbld', 07:36:55 INFO - 'MAIL': '/var/mail/cltbld', 07:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:55 INFO - 'MOZ_NO_REMOTE': '1', 07:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:55 INFO - 'NO_EM_RESTART': '1', 07:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:55 INFO - 'PWD': '/builds/slave/test', 07:36:55 INFO - 'SHELL': '/bin/bash', 07:36:55 INFO - 'SHLVL': '1', 07:36:55 INFO - 'TERM': 'linux', 07:36:55 INFO - 'TMOUT': '86400', 07:36:55 INFO - 'USER': 'cltbld', 07:36:55 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:55 INFO - '_': '/tools/buildbot/bin/python'} 07:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:56 INFO - Downloading/unpacking psutil>=0.7.1 07:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:36:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:57 INFO - Installing collected packages: psutil 07:36:57 INFO - Running setup.py install for psutil 07:36:57 INFO - building 'psutil._psutil_linux' extension 07:36:57 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 07:36:58 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 07:36:58 INFO - building 'psutil._psutil_posix' extension 07:36:58 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 07:36:58 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 07:36:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:58 INFO - Successfully installed psutil 07:36:58 INFO - Cleaning up... 07:36:58 INFO - Return code: 0 07:36:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:58 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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:36:58 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 07:36:58 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 07:36:58 INFO - Using env: {'DISPLAY': ':0', 07:36:58 INFO - 'HOME': '/home/cltbld', 07:36:58 INFO - 'LANG': 'en_US.UTF-8', 07:36:58 INFO - 'LANGUAGE': 'en_US:en', 07:36:58 INFO - 'LOGNAME': 'cltbld', 07:36:58 INFO - 'MAIL': '/var/mail/cltbld', 07:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:58 INFO - 'MOZ_NO_REMOTE': '1', 07:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:58 INFO - 'NO_EM_RESTART': '1', 07:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:58 INFO - 'PWD': '/builds/slave/test', 07:36:58 INFO - 'SHELL': '/bin/bash', 07:36:58 INFO - 'SHLVL': '1', 07:36:58 INFO - 'TERM': 'linux', 07:36:58 INFO - 'TMOUT': '86400', 07:36:58 INFO - 'USER': 'cltbld', 07:36:58 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:58 INFO - '_': '/tools/buildbot/bin/python'} 07:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:36:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:36:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:37:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:37:00 INFO - Installing collected packages: mozsystemmonitor 07:37:00 INFO - Running setup.py install for mozsystemmonitor 07:37:00 INFO - Successfully installed mozsystemmonitor 07:37:00 INFO - Cleaning up... 07:37:00 INFO - Return code: 0 07:37:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:00 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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:37:00 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 07:37:00 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 07:37:00 INFO - Using env: {'DISPLAY': ':0', 07:37:00 INFO - 'HOME': '/home/cltbld', 07:37:00 INFO - 'LANG': 'en_US.UTF-8', 07:37:00 INFO - 'LANGUAGE': 'en_US:en', 07:37:00 INFO - 'LOGNAME': 'cltbld', 07:37:00 INFO - 'MAIL': '/var/mail/cltbld', 07:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:00 INFO - 'MOZ_NO_REMOTE': '1', 07:37:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:00 INFO - 'NO_EM_RESTART': '1', 07:37:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:00 INFO - 'PWD': '/builds/slave/test', 07:37:00 INFO - 'SHELL': '/bin/bash', 07:37:00 INFO - 'SHLVL': '1', 07:37:00 INFO - 'TERM': 'linux', 07:37:00 INFO - 'TMOUT': '86400', 07:37:00 INFO - 'USER': 'cltbld', 07:37:00 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:00 INFO - '_': '/tools/buildbot/bin/python'} 07:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:00 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 07:37:00 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 07:37:00 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 07:37:00 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 07:37:00 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 07:37:00 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 07:37:02 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:02 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 07:37:02 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 07:37:02 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 07:37:02 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 07:37:02 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 07:37:02 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 07:37:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 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 07:37:03 INFO - Downloading docopt-0.6.1.tar.gz 07:37:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:37:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:03 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:03 INFO - Running setup.py install for blobuploader 07:37:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:03 INFO - Running setup.py install for requests 07:37:03 INFO - Running setup.py install for docopt 07:37:03 INFO - Successfully installed blobuploader requests docopt 07:37:03 INFO - Cleaning up... 07:37:03 INFO - Return code: 0 07:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:03 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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:37:03 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 07:37:03 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 07:37:03 INFO - Using env: {'DISPLAY': ':0', 07:37:03 INFO - 'HOME': '/home/cltbld', 07:37:03 INFO - 'LANG': 'en_US.UTF-8', 07:37:03 INFO - 'LANGUAGE': 'en_US:en', 07:37:03 INFO - 'LOGNAME': 'cltbld', 07:37:03 INFO - 'MAIL': '/var/mail/cltbld', 07:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:03 INFO - 'MOZ_NO_REMOTE': '1', 07:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:03 INFO - 'NO_EM_RESTART': '1', 07:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:03 INFO - 'PWD': '/builds/slave/test', 07:37:03 INFO - 'SHELL': '/bin/bash', 07:37:03 INFO - 'SHLVL': '1', 07:37:03 INFO - 'TERM': 'linux', 07:37:03 INFO - 'TMOUT': '86400', 07:37:03 INFO - 'USER': 'cltbld', 07:37:03 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:03 INFO - '_': '/tools/buildbot/bin/python'} 07:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:04 INFO - Running setup.py (path:/tmp/pip-HRwVF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:04 INFO - Running setup.py (path:/tmp/pip-p3LfUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:04 INFO - Running setup.py (path:/tmp/pip-ScLPX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:04 INFO - Running setup.py (path:/tmp/pip-lFzDe_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:04 INFO - Running setup.py (path:/tmp/pip-oNw2CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:04 INFO - Running setup.py (path:/tmp/pip-_vgvdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:04 INFO - Running setup.py (path:/tmp/pip-FocPDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:04 INFO - Running setup.py (path:/tmp/pip-uPwiBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:04 INFO - Running setup.py (path:/tmp/pip-rQqkpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:04 INFO - Running setup.py (path:/tmp/pip-EuoTlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:04 INFO - Running setup.py (path:/tmp/pip-uFBHlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:04 INFO - Running setup.py (path:/tmp/pip-7I8aTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:05 INFO - Running setup.py (path:/tmp/pip-JSKuF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:05 INFO - Running setup.py (path:/tmp/pip-fK97rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:05 INFO - Running setup.py (path:/tmp/pip-ACF6bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:05 INFO - Running setup.py (path:/tmp/pip-Dq87ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:05 INFO - Running setup.py (path:/tmp/pip-TGA0RN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:05 INFO - Running setup.py install for manifestparser 07:37:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:05 INFO - Running setup.py install for mozcrash 07:37:05 INFO - Running setup.py install for mozdebug 07:37:05 INFO - Running setup.py install for mozdevice 07:37:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:05 INFO - Running setup.py install for mozfile 07:37:05 INFO - Running setup.py install for mozhttpd 07:37:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for mozinfo 07:37:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for mozInstall 07:37:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for mozleak 07:37:06 INFO - Running setup.py install for mozlog 07:37:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for moznetwork 07:37:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for mozprocess 07:37:06 INFO - Running setup.py install for mozprofile 07:37:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for mozrunner 07:37:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:06 INFO - Running setup.py install for mozscreenshot 07:37:06 INFO - Running setup.py install for moztest 07:37:07 INFO - Running setup.py install for mozversion 07:37:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:07 INFO - Cleaning up... 07:37:07 INFO - Return code: 0 07:37:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:07 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')]} 07:37:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:07 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')]} 07:37:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:07 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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:37:07 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 07:37:07 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 07:37:07 INFO - Using env: {'DISPLAY': ':0', 07:37:07 INFO - 'HOME': '/home/cltbld', 07:37:07 INFO - 'LANG': 'en_US.UTF-8', 07:37:07 INFO - 'LANGUAGE': 'en_US:en', 07:37:07 INFO - 'LOGNAME': 'cltbld', 07:37:07 INFO - 'MAIL': '/var/mail/cltbld', 07:37:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:07 INFO - 'MOZ_NO_REMOTE': '1', 07:37:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:07 INFO - 'NO_EM_RESTART': '1', 07:37:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:07 INFO - 'PWD': '/builds/slave/test', 07:37:07 INFO - 'SHELL': '/bin/bash', 07:37:07 INFO - 'SHLVL': '1', 07:37:07 INFO - 'TERM': 'linux', 07:37:07 INFO - 'TMOUT': '86400', 07:37:07 INFO - 'USER': 'cltbld', 07:37:07 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:07 INFO - '_': '/tools/buildbot/bin/python'} 07:37:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:07 INFO - Running setup.py (path:/tmp/pip-dyfFCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:07 INFO - Running setup.py (path:/tmp/pip-KWUDza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:07 INFO - Running setup.py (path:/tmp/pip-KG8Bt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:07 INFO - Running setup.py (path:/tmp/pip-RZkpBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:07 INFO - Running setup.py (path:/tmp/pip-YWhjKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:07 INFO - Running setup.py (path:/tmp/pip-aYDJNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:07 INFO - Running setup.py (path:/tmp/pip-dkUG9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:07 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)) 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:07 INFO - Running setup.py (path:/tmp/pip-c34tEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:08 INFO - Running setup.py (path:/tmp/pip-8Ek9vG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:08 INFO - Running setup.py (path:/tmp/pip-S7T0ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:08 INFO - Running setup.py (path:/tmp/pip-65lAs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:08 INFO - Running setup.py (path:/tmp/pip-MRGLK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:08 INFO - Running setup.py (path:/tmp/pip-rV5zwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:08 INFO - Running setup.py (path:/tmp/pip-xIBRiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:08 INFO - Running setup.py (path:/tmp/pip-_adLda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:08 INFO - Running setup.py (path:/tmp/pip-7_e65o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:08 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)) 07:37:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:08 INFO - Running setup.py (path:/tmp/pip-p9p5zm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:08 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)) 07:37:08 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)) 07:37:08 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)) 07:37:08 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)) 07:37:08 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)) 07:37:08 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)) 07:37:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:10 INFO - Downloading blessings-1.5.1.tar.gz 07:37:10 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 07:37:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:10 INFO - Installing collected packages: blessings 07:37:10 INFO - Running setup.py install for blessings 07:37:10 INFO - Successfully installed blessings 07:37:10 INFO - Cleaning up... 07:37:10 INFO - Return code: 0 07:37:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:10 INFO - Reading from file tmpfile_stdout 07:37:10 INFO - Current package versions: 07:37:10 INFO - argparse == 1.2.1 07:37:10 INFO - blessings == 1.5.1 07:37:10 INFO - blobuploader == 1.2.4 07:37:10 INFO - docopt == 0.6.1 07:37:10 INFO - manifestparser == 1.1 07:37:10 INFO - mozInstall == 1.12 07:37:10 INFO - mozcrash == 0.16 07:37:10 INFO - mozdebug == 0.1 07:37:10 INFO - mozdevice == 0.47 07:37:10 INFO - mozfile == 1.2 07:37:10 INFO - mozhttpd == 0.7 07:37:10 INFO - mozinfo == 0.9 07:37:10 INFO - mozleak == 0.1 07:37:10 INFO - mozlog == 3.1 07:37:10 INFO - moznetwork == 0.27 07:37:10 INFO - mozprocess == 0.22 07:37:10 INFO - mozprofile == 0.27 07:37:10 INFO - mozrunner == 6.11 07:37:10 INFO - mozscreenshot == 0.1 07:37:10 INFO - mozsystemmonitor == 0.0 07:37:10 INFO - moztest == 0.7 07:37:10 INFO - mozversion == 1.4 07:37:10 INFO - psutil == 3.1.1 07:37:10 INFO - requests == 1.2.3 07:37:10 INFO - wsgiref == 0.1.2 07:37:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:37:10 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 07:37:10 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 07:37:10 INFO - Using env: {'DISPLAY': ':0', 07:37:10 INFO - 'HOME': '/home/cltbld', 07:37:10 INFO - 'LANG': 'en_US.UTF-8', 07:37:10 INFO - 'LANGUAGE': 'en_US:en', 07:37:10 INFO - 'LOGNAME': 'cltbld', 07:37:10 INFO - 'MAIL': '/var/mail/cltbld', 07:37:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:10 INFO - 'MOZ_NO_REMOTE': '1', 07:37:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:10 INFO - 'NO_EM_RESTART': '1', 07:37:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:10 INFO - 'PWD': '/builds/slave/test', 07:37:10 INFO - 'SHELL': '/bin/bash', 07:37:10 INFO - 'SHLVL': '1', 07:37:10 INFO - 'TERM': 'linux', 07:37:10 INFO - 'TMOUT': '86400', 07:37:10 INFO - 'USER': 'cltbld', 07:37:10 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:10 INFO - '_': '/tools/buildbot/bin/python'} 07:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 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)) 07:37:11 INFO - Cleaning up... 07:37:11 INFO - Return code: 0 07:37:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:37: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', 'jsonschema'] in /builds/slave/test/build 07:37: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 jsonschema 07:37:11 INFO - Using env: {'DISPLAY': ':0', 07:37:11 INFO - 'HOME': '/home/cltbld', 07:37:11 INFO - 'LANG': 'en_US.UTF-8', 07:37:11 INFO - 'LANGUAGE': 'en_US:en', 07:37:11 INFO - 'LOGNAME': 'cltbld', 07:37:11 INFO - 'MAIL': '/var/mail/cltbld', 07:37:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:11 INFO - 'MOZ_NO_REMOTE': '1', 07:37:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:11 INFO - 'NO_EM_RESTART': '1', 07:37:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:11 INFO - 'PWD': '/builds/slave/test', 07:37:11 INFO - 'SHELL': '/bin/bash', 07:37:11 INFO - 'SHLVL': '1', 07:37:11 INFO - 'TERM': 'linux', 07:37:11 INFO - 'TMOUT': '86400', 07:37:11 INFO - 'USER': 'cltbld', 07:37:11 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:11 INFO - '_': '/tools/buildbot/bin/python'} 07:37:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:11 INFO - Downloading/unpacking jsonschema 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:12 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 07:37:12 INFO - Downloading/unpacking functools32 (from jsonschema) 07:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:13 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:37:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:13 INFO - warning: no files found matching '*.txt' 07:37:13 INFO - no previously-included directories found matching 'build' 07:37:13 INFO - no previously-included directories found matching 'dist' 07:37:13 INFO - no previously-included directories found matching '.git*' 07:37:13 INFO - Installing collected packages: jsonschema, functools32 07:37:13 INFO - Running setup.py install for functools32 07:37:13 INFO - warning: no files found matching '*.txt' 07:37:13 INFO - no previously-included directories found matching 'build' 07:37:13 INFO - no previously-included directories found matching 'dist' 07:37:13 INFO - no previously-included directories found matching '.git*' 07:37:13 INFO - Successfully installed jsonschema functools32 07:37:13 INFO - Cleaning up... 07:37:13 INFO - Return code: 0 07:37:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:37: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')]} 07:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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')]} 07:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d6002df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x144f240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, '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': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', '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 07:37: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', 'flake8'] in /builds/slave/test/build 07:37: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 flake8 07:37:13 INFO - Using env: {'DISPLAY': ':0', 07:37:13 INFO - 'HOME': '/home/cltbld', 07:37:13 INFO - 'LANG': 'en_US.UTF-8', 07:37:13 INFO - 'LANGUAGE': 'en_US:en', 07:37:13 INFO - 'LOGNAME': 'cltbld', 07:37:13 INFO - 'MAIL': '/var/mail/cltbld', 07:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:13 INFO - 'MOZ_NO_REMOTE': '1', 07:37:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:13 INFO - 'NO_EM_RESTART': '1', 07:37:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:13 INFO - 'PWD': '/builds/slave/test', 07:37:13 INFO - 'SHELL': '/bin/bash', 07:37:13 INFO - 'SHLVL': '1', 07:37:13 INFO - 'TERM': 'linux', 07:37:13 INFO - 'TMOUT': '86400', 07:37:13 INFO - 'USER': 'cltbld', 07:37:13 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:13 INFO - '_': '/tools/buildbot/bin/python'} 07:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:13 INFO - Downloading/unpacking flake8 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:37:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 07:37:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:37:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 07:37:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 07:37:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:37:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:37:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:37:15 INFO - no previously-included directories found matching 'docs/_build' 07:37:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:37:16 INFO - Running setup.py install for pep8 07:37:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:37:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:37:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:37:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:37:16 INFO - no previously-included directories found matching 'docs/_build' 07:37:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:37:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:37:16 INFO - Cleaning up... 07:37:16 INFO - Return code: 0 07:37:16 INFO - Running post-action listener: _resource_record_post_action 07:37:16 INFO - Running post-action listener: _start_resource_monitoring 07:37:16 INFO - Starting resource monitoring. 07:37:16 INFO - ##### 07:37:16 INFO - ##### Running install step. 07:37:16 INFO - ##### 07:37:16 INFO - Running pre-action listener: _resource_record_pre_action 07:37:16 INFO - Running main action method: install 07:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:16 INFO - Reading from file tmpfile_stdout 07:37:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:16 INFO - Reading from file tmpfile_stdout 07:37:16 INFO - Output received: 07:37:16 INFO - Usage: mozinstall [options] installer 07:37:16 INFO - Options: 07:37:16 INFO - -h, --help show this help message and exit 07:37:16 INFO - -d DEST, --destination=DEST 07:37:16 INFO - Directory to install application into. [default: 07:37:16 INFO - "/builds/slave/test"] 07:37:16 INFO - --app=APP Application being installed. [default: firefox] 07:37:16 INFO - mkdir: /builds/slave/test/build/application 07:37:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:37:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:37:31 INFO - Reading from file tmpfile_stdout 07:37:31 INFO - Output received: 07:37:31 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:31 INFO - Running post-action listener: _resource_record_post_action 07:37:31 INFO - ##### 07:37:31 INFO - ##### Running run-tests step. 07:37:31 INFO - ##### 07:37:31 INFO - Running pre-action listener: _resource_record_pre_action 07:37:31 INFO - Running main action method: run_tests 07:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:31 INFO - Python 2.7.3 07:37:31 INFO - Return code: 0 07:37:31 INFO - grabbing minidump binary from tooltool 07:37:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:37:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14de0b0>, '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 0x14defb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14df440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:37:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:37:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:31 INFO - Return code: 0 07:37:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:37:32 INFO - Return code: 0 07:37:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test/build 07:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 07:37:32 INFO - Using env: {'DISPLAY': ':0', 07:37:32 INFO - 'HOME': '/home/cltbld', 07:37:32 INFO - 'LANG': 'en_US.UTF-8', 07:37:32 INFO - 'LANGUAGE': 'en_US:en', 07:37:32 INFO - 'LOGNAME': 'cltbld', 07:37:32 INFO - 'MAIL': '/var/mail/cltbld', 07:37:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:32 INFO - 'MOZ_NO_REMOTE': '1', 07:37:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:32 INFO - 'NO_EM_RESTART': '1', 07:37:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:32 INFO - 'PWD': '/builds/slave/test', 07:37:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:32 INFO - 'SHELL': '/bin/bash', 07:37:32 INFO - 'SHLVL': '1', 07:37:32 INFO - 'TERM': 'linux', 07:37:32 INFO - 'TMOUT': '86400', 07:37:32 INFO - 'USER': 'cltbld', 07:37:32 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552', 07:37:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:32 INFO - '_': '/tools/buildbot/bin/python'} 07:37:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 07:37:32 INFO - mozversion INFO | application_buildid: 20151214064931 07:37:32 INFO - mozversion INFO | application_changeset: a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 07:37:32 INFO - mozversion INFO | application_display_name: Nightly 07:37:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:32 INFO - mozversion INFO | application_name: Firefox 07:37:32 INFO - mozversion INFO | application_remotingname: firefox 07:37:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:37:32 INFO - mozversion INFO | application_vendor: Mozilla 07:37:32 INFO - mozversion INFO | application_version: 45.0a1 07:37:32 INFO - mozversion INFO | platform_buildid: 20151214064931 07:37:32 INFO - mozversion INFO | platform_changeset: a5a1cf9c5a9ea302a1fbeab1c5fd89c74be24e69 07:37:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:37:32 INFO - mozversion INFO | platform_version: 45.0a1 07:37:32 INFO - 2015-12-14 07:37:32,241 DEBUG : using testdate: 1450107452 07:37:32 INFO - 2015-12-14 07:37:32,241 DEBUG : actual date: 1450107452 07:37:32 INFO - 2015-12-14 07:37:32,249 INFO : starting webserver on 'localhost:33288' 07:37:32 INFO - 2015-12-14 07:37:32,250 INFO : Starting test suite talos-linux64-ix-045 07:37:32 INFO - 2015-12-14 07:37:32,251 INFO : Starting test dromaeo_css 07:37:32 INFO - 2015-12-14 07:37:32,251 DEBUG : operating with platform_type : linux_ 07:37:32 INFO - 2015-12-14 07:37:32,252 INFO : Initialising browser for dromaeo_css test... 07:37:32 INFO - 2015-12-14 07:37:32,268 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprlAl0b/profile http://localhost:33288/getInfo.html 07:37:36 INFO - 2015-12-14 07:37:36,448 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:37:36 INFO - 2015-12-14 07:37:36,448 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:37:36 INFO - 2015-12-14 07:37:36,448 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:37:36 INFO - 2015-12-14 07:37:36,448 DEBUG : BROWSER_OUTPUT: __metrics 07:37:36 INFO - 2015-12-14 07:37:36,525 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] 07:37:36 INFO - 2015-12-14 07:37:36,580 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] 07:37:37 INFO - 2015-12-14 07:37:37,789 INFO : Browser initialized. 07:37:37 INFO - 2015-12-14 07:37:37,789 INFO : Running cycle 1/1 for dromaeo_css test... 07:37:37 INFO - 2015-12-14 07:37:37,790 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprlAl0b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:37:49 INFO - 2015-12-14 07:37:49,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 141975552 07:37:49 INFO - 2015-12-14 07:37:49,825 DEBUG : BROWSER_OUTPUT: 07:38:40 INFO - 2015-12-14 07:38:40,885 DEBUG : BROWSER_OUTPUT: 1450107520883 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] 07:40:52 INFO - 2015-12-14 07:40:52,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33288/tests/dromaeo/cssquery-ext.html) 07:40:53 INFO - 2015-12-14 07:40:53,829 DEBUG : BROWSER_OUTPUT: RSS: Main: 224182272 07:40:53 INFO - 2015-12-14 07:40:53,830 DEBUG : BROWSER_OUTPUT: 07:43:56 INFO - 2015-12-14 07:43:56,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/dromaeo/cssquery-ext.html (next: http://localhost:33288/tests/dromaeo/cssquery-jquery.html) 07:43:56 INFO - 2015-12-14 07:43:56,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 224899072 07:43:56 INFO - 2015-12-14 07:43:56,849 DEBUG : BROWSER_OUTPUT: 07:46:59 INFO - 2015-12-14 07:46:59,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33288/tests/dromaeo/cssquery-mootools.html) 07:46:59 INFO - 2015-12-14 07:46:59,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 214343680 07:46:59 INFO - 2015-12-14 07:46:59,602 DEBUG : BROWSER_OUTPUT: 07:50:01 INFO - 2015-12-14 07:50:01,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33288/tests/dromaeo/cssquery-prototype.html) 07:50:02 INFO - 2015-12-14 07:50:02,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 208551936 07:50:02 INFO - 2015-12-14 07:50:02,147 DEBUG : BROWSER_OUTPUT: 07:53:04 INFO - 2015-12-14 07:53:04,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33288/tests/dromaeo/cssquery-yui.html) 07:53:05 INFO - 2015-12-14 07:53:05,543 DEBUG : BROWSER_OUTPUT: RSS: Main: 206594048 07:53:05 INFO - 2015-12-14 07:53:05,544 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,062 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/dromaeo/cssquery-yui.html (next: http://localhost:33288/tests/dromaeo/cssquery-dojo.html) 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 256577536 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2559.270607876755;2661.4677064587077;2669.8665066746657;2679.9464010719785;2680.396910695093;4516.254817955041;4646.442426908768;4675.906481870365;4684.601808846248;4716.221823399139;4618.422697162855;4644.187267228239;4712.952870471294;4718.551737584932;4733.905321893569;4326.459192600925;4326.545712700176;4327.913441731163;4328.956710432887;4352.586504282088;4186.769727664977;4377.496587892385;4379.802908869108;4440.467143942716;4449.777511124431;4235.745855248664;4296.914061718748;4304.870853874389;4308.633766129883;4330.090680957002;4323.783810809447;4343.2399330117105;4360.738355698668;4373.825046998117;4413.3821265022925;4147.543770185277;4242.703010789246;4328.9783551082355;4345.9130817383475;4394.516603173648;4511.751853648048;4524.909501809978;4596.35651008859;4611.054733779567;4626.4910859805395;5012.974935125338;5026.29631851541;5029.1953287473825;5073;5079.74601269935;4824.565789079;5049.5707864831165;5049.974750126263;5053.090443720129;5061.746912654389;4582.221022426195;4613.423322084739;4626.329182268552;4626.676132670715;4659;5132.897342053138;5189.325387699575;5195.324607801037;5203.479652034766;5204.4535323791215;4799.6400269979895;4989.675671081368;4990.575801056878;4991.276264941564;5005.3242812220615;4935.259711043301;4998;5010.048090862724;5020.874478138076;5051.646384753032;4979.551840334388;4994.375703037121;4995.650304478651;4997.075541024922;5041.949580504222;4964.255361695702;4965.875853103629;4967.279744437036;4967.925481117786;5020.573251273682;4001.7398869073418;4070.5115386153852;4105.261053010427;4105.527864295585;4106.993786522261;3687.022938921188;3709.4435834624483;3709.703223742094;3714.201446688975;3716.4982727332003;4253.361995700608;4327.091310824762;4327.870163895025;4358.433403657505;4370.584794444522;5026.346574945307;5033.496650334937;5037.697738135724;5039;5040.042391945519;4149.398337241083;4252.319628859368;4322.589354011364;4324.935125973113;4361.454818147731;4326.891827704269;4385.232584297735;4412.757298348557;4424.80088396023;4467.374567560544;4712.976435117803;4716.5990890774665;4723.291506274018;4727.598154156866;4788.640851936118;4810.903781924412;4923.926141107958;4933.087378834927;4982.227754698028;5032.6225533084435;4707.270373092176;4729.905401891874;4795.9280610790165;4832.806687732592;4859.441164266154;4989.501049894981;4995.300657907968;5000.074986127578;5003.4246061701915;5038.546530812245;4817.662763606654;5062.974685126551;5066.721330326867;5069.8732531687;5118.309028281284;4779.904401911873;4813.229883218668;4829.13075646373;4871.19625261842;4916.336294600326;4821.421429428491;4831.830885918976;4837.201861692782;4838.7338696370625;4879.829205977774;4600.907981840412;4717.268823332389;4731.077439899186;4735.266033764772;4781.760911954458;4671.205894997791;4778.546038126373;4830.396200474941;4835.081334546425;4845.3216549682365;4798.712077275374;4821.059893320768;4823.2282834746275;4823.2282834746275;4864.221724524059 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.4098226371177;573.2175580332847;573.6357413042718;580.2688612348439;582.0977484898407;27653.585196222048;28223.85888070562;28268.575971360446;28303.575446368322;28322.291942701417;28305;37210.441843372304;38196.809015954954;38228.61771382285;38265.23469530608;7926.40551958604;8082.636281367352;8082.919170808304;8085.878711819328;8087.676492940304;7227.494075414723;7862.606869656494;7924.484908480959;7981.6009199540085;7981.9201807982045;7194.280571942816;10226.744331391701;10530.31552949056;10531.157507399428;10532.15742740579;10026.799464010715;10151.340162889463;10153.39079655223;10160.288779785418;10163.136133428667;7277.126744790606;7477.289657482531;7482.401407887356;9802.313838031341;9943.651972180938;37754.62245377539;38616.227675446615;38704.80647596744;38766.80616596899;38833.61166388328;2900.912972610825;2932.0763959352735;2938.3241854373614;3140.230643492336;3594.939492849616;27296.727032729617;27397.863010685018;27543.31141721473;27822;27865.164045078476;3217.871285148615;3296.126526470487;3314.453115235983;3343.732501399882;3441.380551500729;227254;228693;230521;230775;231082;57401;57544.71227643835;57695.71152144212;57815;57933.4206657928;62153.68923155355;62378.68810656008;62380;62405.37594624086;62455;12825.102242843099;12942.288174150512;13223.867761322455;13224;13313.46746130144;10336.844947325797;10376.948115259376;10421.739456513647;10446.112080473093;10455.477226138662;19569.217231310588;20048.198072077244;20059.799402006083;20083.297084601967;20089.598208036048;7832;7922.405819563556;7960.283574478325;8065;8078.313343365762;806.4757907360146;831.2269589282025;847.559269180023;851.7231899632644;971.5385192033727;26083.869580651975;26449.53614843232;26512.337191570365;26704.8664756675;26734.331641708723;829.8423299573062;900.2392977933636;952.0289304908954;997.870276864003;999.9900000999897;12499.687507812196;12537.550979806987;13101.148425352321;13108.279044652445;13263.005274604444;271922;276286;276444;276556;277270;46396.536034639896;46715.29927051097;46731.532684673395;46914.061718765435;46916;1220.334917469981;1235.6910772307103;1238.8141778733082;1249.2254802022621;1370.6093763277418;23715.56032469917;24051.37244523446;24504.873781554612;24540.631890522014;24602.55980968858;38265.80867095647;38590.80704596459;38984.220315594095;39004.41493377545;39061.8046909775;235246;258855;260351;260510;260673;23990.28029159128;28842.134735957956;28860.7113928858;29081.418371632873;29422.11733647994;33767.32465350728;37065.62934370622;37445.25109497849;37466.812665937585;37884.24231515409;29954.400911982073;31799.841000794848;32011;32148.839255804505;32469.837650811594;31270.843645782537;38114.80942595269;39003.41494877522;40728;41333;38874;39075;39649.603503964594;39741.40387894126;40204;27465.72534274632;28792.84053696023;30670.233244169074;32875.67124328822;36333.45499817452;23747.16884909089;23843.523129537658;23896.610338965966;23914.043438262273;24238 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.29434304930504;333.60801058755953;335.12866546977847;335.23064566819147;338.2693382294245;12460.875391246085;12798.808017879739;14804.55586332409;15256.313465894034;16004.199790010496;9489.762755931106;9604.807903841918;9649.903500964989;9743.805123897535;9891.653792117277;4467.352233926087;4587.2201725706545;4598.195315819718;4600.217962946291;4600.332951722015;3491.039964009892;3602.477640742091;5134.691918484884;5289.047971365153;5296.867578310535;5234.084035293828;5252.947470525303;5255.343082114736;5257.342832145981;5266.7366631668265;5124.692518448886;5271.894562108736;5278.762455689503;5287.180487024518;5291.100512912775;5059.06407314648;5078.4921507849285;5098;5104.03023425548;5107.1828507439;15148.788096952218;19308.613827723508;19751.506212344662;19751.703724444145;19866.70199947002;1721.1396976858186;1838.0442170071622;1838.6966150585138;1842.3551756885117;1884.35931783193;9016.18854303116;9192.678256261066;9305.395149315273;11169.385683787388;12607.936960315232;1746.2229307957964;1767.3902503636225;1774.9290028398848;1813.5466133466634;1824.3705921457076;54638.45361546413;56055.71972140195;57046.14430783541;57399.42600573983;58686.41313586852;9449.716508504756;9756.90243097574;9799.314048016571;9841.065098815601;9879.75300617476;12554.748905021848;12652.557160499338;12659.177153484994;12672.80990785139;12676.936615316865;6388.744450222032;6419.80740577774;6434.453071488976;6477.514186436036;6626;6214.098955651405;6218.378162183745;6228.065790131516;6236.438720515175;6247.656378899113;4177.644900183518;4225.154969006211;4226.746395216235;4233.894152646209;4268.59448352406;1612.6129728864987;1665.600255938566;1675.7737705409857;1694.2375930830929;1711;796.2236819101446;853.1255463150196;916.9266458683289;943.2227605913778;963.5808423335872;10281.074703276741;15203.31585078652;15603.765943510856;15828.68342633164;16615.50153495397;346.7693983500994;350.04088796697374;356.59526437493633;378.92042671038837;384.4924699396825;5150.742462876841;5359.196120581944;5430.104032834538;5527.198556209408;5539.529140023063;480174;480377;502399;508466;509360;74426.62786686032;74485.62757186287;74773.62613187009;75086.62456687681;75599.62200188964;441.60255769806787;442.2305188971167;442.312204521965;446.98659040228847;447.57927548104027;9261.814763704553;9291.953540232256;9382.10869967352;9419.293552983416;9452.858207126761;31988.520172197903;32255.193620158745;32322.515162273055;32659.836700816344;33696.3260734779;44426.11147776962;44555;44791.32813007873;45747.31379029251;46055.76972115118;8955.104489550993;9060.365774395728;9212.170904618617;9249.76875578089;9293;16158.353665853234;16486.75269870977;16497.505074847773;16760.497185084467;16785.32858685639;13873.791893121814;13947.232902190477;14094.436222550983;14220.288985550887;14385;13646.317684115953;13776.793348099585;13823.930880345533;13970.860291396955;13997.300134993005;10946.343219406861;12749;14171;14364.569062928129;14529.491467798576;8108.797280068045;8451.535165565952;8516.318694504549;8536.871946920925;8850.336224783296;13831.723365532835;13941.860581394056;14023.368948397143;14226.644333891736;14736.2631868404 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1428.1217051513322;1670.908100054497;1712.9314827406904;1730.662520808442;1737.9919646604963;5789.884202315957;6698.765543205989;6900.5859648421065;6917.06619606353;6930.549514281568;6866.107406037208;7035.2612975637585;7038;7047.788566343018;7048;1687.9156042197903;1718.9398371057016;1721.208244207666;2004.6892731626585;2037.8573499854942;1719.5701074731317;1727.2572793698705;1964.8329891959202;2003.3088584438347;2012.8490363222743;2030.766461856883;2033.7661168965537;2038.5617092325147;2039.7450318710162;2040.2349119080345;1916.1473144450724;1977.0608960743675;1979.792121827209;1980.4454752669276;1983.1868933737098;2001.5296405344732;2013.5268211970322;2026.6048120616485;2029.6448121578812;2040.6530889748778;6900.896486552706;6950.721971121149;6961.060256865309;6969.895451568231;6970.651467426608;4071.3485842265095;4089.2434899543678;4117.649999750025;4133.42132101506;4143.02638879863;2558.270892795544;2608.6608740863758;2610.8955641774305;2649.0728245114246;2649.3509090272814;807.3379828540599;810.0846043970275;811.4644334739044;837.995810020952;862.6937437209825;9054.592543335566;9065.957414897239;9067.818643627157;9069.909300906973;9076.68231611897;3720.1443667956523;3740.6446387593137;3790.6209379061875;3800.5439347278502;3821.178446633987;7932.0878099019355;7951.324137448266;7951.880721789178;7952.880706789403;7958.482698624571;4152.792360382029;4155.750654960712;4173.749575025508;4180.122174343361;4180.435641188462;3798.3922572388838;3798.6581207691443;3799.5630502492013;3800.1639639279315;3800.9239815204096;3314.1880239341517;3320.26954070109;3345.5483509725877;3362.36115138123;3370.764046516769;898.9775255618531;899.8155378147464;1004.9447280399502;1056.2447849787438;1065.3980501016902;908.8000639859221;909.1136142261374;926.5552534783342;958.5542722634009;1167.3287859480663;6555.6066636002;6596.80209593713;6628;6630.270670226271;6644.202695676453;964.392432767352;967.5549247346158;976.2873102635116;1062.5324857063022;1070.4059247117768;4827.324174615556;4942.332785073969;4949.628777841676;4953;4958.826441074545;8016.639251233709;8043.436959412785;8314.501129932223;8318.750437486886;8322.084570697218;8102.230288122737;8185.3451723861945;8193.139720329398;8200.466969647074;8208;6329.841753956096;6498.090267362573;6528.151340325822;6623.668816559153;6639.834004149935;6667.2666006738245;6708.329167083448;6717.361850624183;6722;6732.697028633821;7301.4158867289425;7454.701811927463;7524.849503009799;7572.318491335806;7575.393968482618;7539.962300188464;7713.6143192841255;7747;7755.883661745192;7808.648610812641;5948;6015.428534289235;6017.518598512021;6017.638941663514;6020.789272375446;6279.058141278662;6423;6456.386643268882;6460.3862633049785;6462.773802916875;5199;5484.561235101262;6053.243344581927;6183.196184496167;6373.3945275198785;5846.649201047951;5953.434423729739;5979.611325263844;6079.756809727562;6117.908231376444;6200.875982480416;6201.472874805692;6218.595791273553;6219.284782250099;6222.471089957223;5476.151196564539;5900.173975643499;5954.46409823118;5954.880902382015;5957.3744756799915;5819.621724587888;5841.299044114563;5845.41545845429;5860.150278209721;5912.201852749824 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.0570582694119;302.7351067815661;303.9042701549012;305.0953921622389;306.3887544349024;5211.843644690656;5270.868228294295;5326.89346213076;5347.144456886899;5350.705711185883;5193.818216362428;5198.142306519419;5210.296609957654;5232.581393488521;5236.31927849379;3882.514685664292;4091.488563929509;4092.9386059209137;4093.304138296482;4096.160287141136;4006.4390985262085;4025.7383270087353;4096.672266218696;4099.631033207011;4115.403266526352;4042.73722208057;4051.0682543015123;4055.472788537486;4056.290149223889;4061.045654271244;3830.80845957701;3928.292907276689;3942.172143849795;4053;4060.776657283863;3564.6435356464403;3591.299696559172;3600.459931010343;3602.7838329700303;3610.7472476926628;5043.873903152414;5067.366579177603;5069.69581825088;5072.391313042422;5098.59211263098;4663.813447462097;4672.3925889634465;4673.415823022122;4675.158471475133;4682.3210634458155;5371.409144994048;5481.561475082024;5493.450654934514;5502.312210973629;5521.613487055908;3920.196359746245;3922.235164142993;3927.7446965947124;3932.1545867638597;3932.429797679349;5767.307923049219;5778.739956701958;5783.248177736909;5791.305043394819;5791.507721843648;4026;4038.7778672172726;4043.8180281887385;4045.150518391171;4045.615666511677;3871.593482684334;4095.3037983542868;4095.365218391154;4105.466289382421;4106.589341065929;4580.473245576734;4585.358049873021;4586.036932244199;4587.197240482902;4591.265397536378;5500.50495455411;5501.587380946365;5503.284573005563;5505.229267902497;5508.338999320107;1383.9100458470168;1396.5600835736711;1399.181478834893;1403.059949833614;1403.2983508245877;926.0276709455045;933.4772527384687;948.061419194992;949.4208532794989;954.2461455450256;4843.176659967814;4850.5149485051215;4853.174960256765;4853.3447984522345;4864.124457597666;5674.460926212003;5683.715814209356;5690.886182276331;5700.287464066992;5721.399253078367;4847.3698419205275;4850.902981940412;4852.441969173519;4854.004928989549;4867.537583929521;2748.807583469178;2924.5759364892397;3052.114886682837;3079.414911166871;3084.629844418684;5294.92057619136;5306.044911915892;5306.787728490895;5324.281222035053;5384.811531596375;5858.5898987070495;5895.941040589625;5925.259342582177;5925.466707996301;5944.138099975479;5422.810201642924;5434.538064264502;5475.616706830563;5479.178123281539;5485.396606373216;5778.56660750437;5781.046127389102;5786.218860453785;5786.913196302143;5789.478946894799;5517;5609.467100625434;5639.351474580311;5640.717964101696;5640.830775076754;5477.890442191214;5483.479069488551;5486.039943009878;5490.6431081979545;5494.1758736189895;3906.7851268180525;3919.412088186795;3923.136909879936;3938.4486171935378;3940.6650434712224;5633.746481408429;5758.856028599319;5759.568032397503;5770.384292398136;5773.1051686988585;5524.66851988882;5533.059379905506;5535.059039963136;5535.944640553543;5539;5527.419620939743;5528.9723551381985;5529.364123125892;5534.169874518854;5542.612017158922;5406.189071639285;5407.729613519387;5408.513233808976;5413.756380962787;5415.566754659539;5445.945540544544;5587.720613969204;5588.133839254922;5589.413111623384;5592.189132575835;5182.844514664566;5302.522772950453;5320.44135365781;5430.809921652881;5431.646942948696 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: |5;yui.html;596.58537316565;598.9610675306104;625.3652542669191;660.2901880478487;760.9961950190249;11596.594119205829;11776.11679124066;11796.646100616985;11805.645830625073;11833.704157396069;10262.846057309147;11044.668659940215;11094.389808560525;11129.72175695608;11158.665240042792;624.0950621598678;636.9140615251009;804.3565147881671;816.6651672814147;819.1562690428838;814.6944895664126;815.0830315894618;821.6138414944996;822.0874828939902;822.8560001999656;658.6969993802857;839.7102999465175;845.9196376344238;846.8772028055928;846.8899043124416;659.9769008084718;832.854250506162;847.9279261262739;848.1179573243819;848.5629900601195;629.298332359416;630.7193298981955;630.9842253943642;631.2393565753256;631.3623240527055;11314.773704525864;11377.431128443544;11404.486798094105;11404.657860264206;11405.087592992624;10964.616238431616;11229.550817967352;11291.49188286529;11343.489542970587;11575.189736718434;9460.90539094607;9584.137427631547;9599.040095990415;9761.267904907161;9781.16860066888;3336.3160552086765;3353.4634458486526;3362.764606477523;3385.627580966092;3392.1519620094978;39489.80255098735;39650.405243921654;39905.40141897874;40162.19675606472;40471.19057618831;9080.364374493722;9182.425439834506;9191.862122068174;9232.769180770534;9437.386569872937;14803.629909252355;14812.259387030605;14824.851751482563;14826.62933426673;14842.777358339634;6155.230596175478;6278.30938596754;6332.461740751995;6454.838629034218;6504.739810407531;3634.890953271406;3648.5986541480415;3706.79612621303;3714.0343510686876;3730.086128898383;2595.8572278524484;2605.4137818990953;2613.8693065346656;2626.645402870588;2626.855522946218;445.98216071356785;457.320878495434;458.0381199481063;459.37754342865605;471.6933992904571;539.8299535646258;572.8796952639909;587.3744462147799;589.8377946064867;594.6848170469658;7412.518186317872;7418.221086785918;7594.96202518995;7620.123685776207;7733.2266773323345;461.33106994857593;561.6667410924736;590.6220019187723;604.2235727090667;606.7876243314804;3564.3564356435745;3580.445031020196;3598.1184609770776;3673.5959044505084;3811.4663947047434;48361.27458088131;48613;48711.26933095935;49093.50906490961;49145.26282105771;44278.335824962654;45081.32378014332;45454.31818522725;45487.54512454833;45545.08909821785;41032.38451423231;41288.58711412847;41651.7917410411;41845.37231941523;41974.99999999939;7485.887711684438;7518.736844210426;7674.347680447225;8196.59017049157;8238.670453181805;29922.401551969273;30340.393192136475;31206;31291.217719557193;32212.35575288528;39474.80262598669;39512.802435987636;39513.407298891114;39904.401433979096;39933.80033099816;8966;9429.952850235704;9815.852762208715;10323.122534584645;10501.212409069198;10936.070434013198;11049.779004419706;11057.612983545538;11156.330620162817;11277.097832173571;10238.641647542301;10431.94784026075;10442.738931526772;10547.261691681508;10724.571017159225;9921.465838385908;10106.646267380607;10147.985201479793;10318.793624127626;10347.223958203014;10271.845922311022;10388.272820902464;10511.94744026275;10513.632022879163;10698;8754.949406071311;9049.321300902327;9219.539023048956;9752.609895604097;9866.605335786488;8452.74641760748;8540.359473039423;8602.91397086021;8605.096464871098;8980.685676001309 07:56:08 INFO - 2015-12-14 07:56:08,321 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,968 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108568315__endTimestamp 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: Number of tests: 6 07:56:08 INFO - 2015-12-14 07:56:08,322 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,323 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4616.37 Median:4729.91 stddev:486.62 (10.3%) stddev-sans-first:460.58 07:56:08 INFO - 2015-12-14 07:56:08,323 DEBUG : BROWSER_OUTPUT: Values: 2559.3 2661.5 2669.9 2679.9 2680.4 4516.3 4646.4 4675.9 4684.6 4716.2 4618.4 4644.2 4713.0 4718.6 4733.9 4326.5 4326.5 4327.9 4329.0 4352.6 4186.8 4377.5 4379.8 4440.5 4449.8 4235.7 4296.9 4304.9 4308.6 4330.1 4323.8 4343.2 4360.7 4373.8 4413.4 4147.5 4242.7 4329.0 4345.9 4394.5 4511.8 4524.9 4596.4 4611.1 4626.5 5013.0 5026.3 5029.2 5073.0 5079.7 4824.6 5049.6 5050.0 5053.1 5061.7 4582.2 4613.4 4626.3 4626.7 4659.0 5132.9 5189.3 5195.3 5203.5 5204.5 4799.6 4989.7 4990.6 4991.3 5005.3 4935.3 4998.0 5010.0 5020.9 5051.6 4979.6 4994.4 4995.7 4997.1 5041.9 4964.3 4965.9 4967.3 4967.9 5020.6 4001.7 4070.5 4105.3 4105.5 4107.0 3687.0 3709.4 3709.7 3714.2 3716.5 4253.4 4327.1 4327.9 4358.4 4370.6 5026.3 5033.5 5037.7 5039.0 5040.0 4149.4 4252.3 4322.6 4324.9 4361.5 4326.9 4385.2 4412.8 4424.8 4467.4 4713.0 4716.6 4723.3 4727.6 4788.6 4810.9 4923.9 4933.1 4982.2 5032.6 4707.3 4729.9 4795.9 4832.8 4859.4 4989.5 4995.3 5000.1 5003.4 5038.5 4817.7 5063.0 5066.7 5069.9 5118.3 4779.9 4813.2 4829.1 4871.2 4916.3 4821.4 4831.8 4837.2 4838.7 4879.8 4600.9 4717.3 4731.1 4735.3 4781.8 4671.2 4778.5 4830.4 4835.1 4845.3 4798.7 4821.1 4823.2 4823.2 4864.2 07:56:08 INFO - 2015-12-14 07:56:08,323 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,324 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41525.63 Median:32079.92 stddev:66323.85 (206.7%) stddev-sans-first:66438.58 07:56:08 INFO - 2015-12-14 07:56:08,324 DEBUG : BROWSER_OUTPUT: Values: 559.4 573.2 573.6 580.3 582.1 27653.6 28223.9 28268.6 28303.6 28322.3 28305.0 37210.4 38196.8 38228.6 38265.2 7926.4 8082.6 8082.9 8085.9 8087.7 7227.5 7862.6 7924.5 7981.6 7981.9 7194.3 10226.7 10530.3 10531.2 10532.2 10026.8 10151.3 10153.4 10160.3 10163.1 7277.1 7477.3 7482.4 9802.3 9943.7 37754.6 38616.2 38704.8 38766.8 38833.6 2900.9 2932.1 2938.3 3140.2 3594.9 27296.7 27397.9 27543.3 27822.0 27865.2 3217.9 3296.1 3314.5 3343.7 3441.4 227254.0 228693.0 230521.0 230775.0 231082.0 57401.0 57544.7 57695.7 57815.0 57933.4 62153.7 62378.7 62380.0 62405.4 62455.0 12825.1 12942.3 13223.9 13224.0 13313.5 10336.8 10376.9 10421.7 10446.1 10455.5 19569.2 20048.2 20059.8 20083.3 20089.6 7832.0 7922.4 7960.3 8065.0 8078.3 806.5 831.2 847.6 851.7 971.5 26083.9 26449.5 26512.3 26704.9 26734.3 829.8 900.2 952.0 997.9 1000.0 12499.7 12537.6 13101.1 13108.3 13263.0 271922.0 276286.0 276444.0 276556.0 277270.0 46396.5 46715.3 46731.5 46914.1 46916.0 1220.3 1235.7 1238.8 1249.2 1370.6 23715.6 24051.4 24504.9 24540.6 24602.6 38265.8 38590.8 38984.2 39004.4 39061.8 235246.0 258855.0 260351.0 260510.0 260673.0 23990.3 28842.1 28860.7 29081.4 29422.1 33767.3 37065.6 37445.3 37466.8 37884.2 29954.4 31799.8 32011.0 32148.8 32469.8 31270.8 38114.8 39003.4 40728.0 41333.0 38874.0 39075.0 39649.6 39741.4 40204.0 27465.7 28792.8 30670.2 32875.7 36333.5 23747.2 23843.5 23896.6 23914.0 24238.0 07:56:08 INFO - 2015-12-14 07:56:08,324 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,324 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26358.98 Median:2457.47 stddev:81200.43 (3304.2%) stddev-sans-first:81404.69 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: Values: 331.3 333.6 335.1 335.2 338.3 12460.9 12798.8 14804.6 15256.3 16004.2 9489.8 9604.8 9649.9 9743.8 9891.7 4467.4 4587.2 4598.2 4600.2 4600.3 3491.0 3602.5 5134.7 5289.0 5296.9 5234.1 5252.9 5255.3 5257.3 5266.7 5124.7 5271.9 5278.8 5287.2 5291.1 5059.1 5078.5 5098.0 5104.0 5107.2 15148.8 19308.6 19751.5 19751.7 19866.7 1721.1 1838.0 1838.7 1842.4 1884.4 9016.2 9192.7 9305.4 11169.4 12607.9 1746.2 1767.4 1774.9 1813.5 1824.4 54638.5 56055.7 57046.1 57399.4 58686.4 9449.7 9756.9 9799.3 9841.1 9879.8 12554.7 12652.6 12659.2 12672.8 12676.9 6388.7 6419.8 6434.5 6477.5 6626.0 6214.1 6218.4 6228.1 6236.4 6247.7 4177.6 4225.2 4226.7 4233.9 4268.6 1612.6 1665.6 1675.8 1694.2 1711.0 796.2 853.1 916.9 943.2 963.6 10281.1 15203.3 15603.8 15828.7 16615.5 346.8 350.0 356.6 378.9 384.5 5150.7 5359.2 5430.1 5527.2 5539.5 480174.0 480377.0 502399.0 508466.0 509360.0 74426.6 74485.6 74773.6 75086.6 75599.6 441.6 442.2 442.3 447.0 447.6 9261.8 9292.0 9382.1 9419.3 9452.9 31988.5 32255.2 32322.5 32659.8 33696.3 44426.1 44555.0 44791.3 45747.3 46055.8 8955.1 9060.4 9212.2 9249.8 9293.0 16158.4 16486.8 16497.5 16760.5 16785.3 13873.8 13947.2 14094.4 14220.3 14385.0 13646.3 13776.8 13823.9 13970.9 13997.3 10946.3 12749.0 14171.0 14364.6 14529.5 8108.8 8451.5 8516.3 8536.9 8850.3 13831.7 13941.9 14023.4 14226.6 14736.3 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4810.28 Median:6019.21 stddev:2483.29 (41.3%) stddev-sans-first:2477.25 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: Values: 1428.1 1670.9 1712.9 1730.7 1738.0 5789.9 6698.8 6900.6 6917.1 6930.5 6866.1 7035.3 7038.0 7047.8 7048.0 1687.9 1718.9 1721.2 2004.7 2037.9 1719.6 1727.3 1964.8 2003.3 2012.8 2030.8 2033.8 2038.6 2039.7 2040.2 1916.1 1977.1 1979.8 1980.4 1983.2 2001.5 2013.5 2026.6 2029.6 2040.7 6900.9 6950.7 6961.1 6969.9 6970.7 4071.3 4089.2 4117.6 4133.4 4143.0 2558.3 2608.7 2610.9 2649.1 2649.4 807.3 810.1 811.5 838.0 862.7 9054.6 9066.0 9067.8 9069.9 9076.7 3720.1 3740.6 3790.6 3800.5 3821.2 7932.1 7951.3 7951.9 7952.9 7958.5 4152.8 4155.8 4173.7 4180.1 4180.4 3798.4 3798.7 3799.6 3800.2 3800.9 3314.2 3320.3 3345.5 3362.4 3370.8 899.0 899.8 1004.9 1056.2 1065.4 908.8 909.1 926.6 958.6 1167.3 6555.6 6596.8 6628.0 6630.3 6644.2 964.4 967.6 976.3 1062.5 1070.4 4827.3 4942.3 4949.6 4953.0 4958.8 8016.6 8043.4 8314.5 8318.8 8322.1 8102.2 8185.3 8193.1 8200.5 8208.0 6329.8 6498.1 6528.2 6623.7 6639.8 6667.3 6708.3 6717.4 6722.0 6732.7 7301.4 7454.7 7524.8 7572.3 7575.4 7540.0 7713.6 7747.0 7755.9 7808.6 5948.0 6015.4 6017.5 6017.6 6020.8 6279.1 6423.0 6456.4 6460.4 6462.8 5199.0 5484.6 6053.2 6183.2 6373.4 5846.6 5953.4 5979.6 6079.8 6117.9 6200.9 6201.5 6218.6 6219.3 6222.5 5476.2 5900.2 5954.5 5954.9 5957.4 5819.6 5841.3 5845.4 5860.2 5912.2 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4583.01 Median:5234.45 stddev:1351.12 (25.8%) stddev-sans-first:1316.04 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: Values: 296.1 302.7 303.9 305.1 306.4 5211.8 5270.9 5326.9 5347.1 5350.7 5193.8 5198.1 5210.3 5232.6 5236.3 3882.5 4091.5 4092.9 4093.3 4096.2 4006.4 4025.7 4096.7 4099.6 4115.4 4042.7 4051.1 4055.5 4056.3 4061.0 3830.8 3928.3 3942.2 4053.0 4060.8 3564.6 3591.3 3600.5 3602.8 3610.7 5043.9 5067.4 5069.7 5072.4 5098.6 4663.8 4672.4 4673.4 4675.2 4682.3 5371.4 5481.6 5493.5 5502.3 5521.6 3920.2 3922.2 3927.7 3932.2 3932.4 5767.3 5778.7 5783.2 5791.3 5791.5 4026.0 4038.8 4043.8 4045.2 4045.6 3871.6 4095.3 4095.4 4105.5 4106.6 4580.5 4585.4 4586.0 4587.2 4591.3 5500.5 5501.6 5503.3 5505.2 5508.3 1383.9 1396.6 1399.2 1403.1 1403.3 926.0 933.5 948.1 949.4 954.2 4843.2 4850.5 4853.2 4853.3 4864.1 5674.5 5683.7 5690.9 5700.3 5721.4 4847.4 4850.9 4852.4 4854.0 4867.5 2748.8 2924.6 3052.1 3079.4 3084.6 5294.9 5306.0 5306.8 5324.3 5384.8 5858.6 5895.9 5925.3 5925.5 5944.1 5422.8 5434.5 5475.6 5479.2 5485.4 5778.6 5781.0 5786.2 5786.9 5789.5 5517.0 5609.5 5639.4 5640.7 5640.8 5477.9 5483.5 5486.0 5490.6 5494.2 3906.8 3919.4 3923.1 3938.4 3940.7 5633.7 5758.9 5759.6 5770.4 5773.1 5524.7 5533.1 5535.1 5535.9 5539.0 5527.4 5529.0 5529.4 5534.2 5542.6 5406.2 5407.7 5408.5 5413.8 5415.6 5445.9 5587.7 5588.1 5589.4 5592.2 5182.8 5302.5 5320.4 5430.8 5431.6 07:56:08 INFO - 2015-12-14 07:56:08,325 DEBUG : BROWSER_OUTPUT: 07:56:08 INFO - 2015-12-14 07:56:08,326 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12117.70 Median:45516.32 stddev:13798.74 (30.3%) stddev-sans-first:13810.32 07:56:08 INFO - 2015-12-14 07:56:08,327 DEBUG : BROWSER_OUTPUT: Values: 596.6 599.0 625.4 660.3 761.0 11596.6 11776.1 11796.6 11805.6 11833.7 10262.8 11044.7 11094.4 11129.7 11158.7 624.1 636.9 804.4 816.7 819.2 814.7 815.1 821.6 822.1 822.9 658.7 839.7 845.9 846.9 846.9 660.0 832.9 847.9 848.1 848.6 629.3 630.7 631.0 631.2 631.4 11314.8 11377.4 11404.5 11404.7 11405.1 10964.6 11229.6 11291.5 11343.5 11575.2 9460.9 9584.1 9599.0 9761.3 9781.2 3336.3 3353.5 3362.8 3385.6 3392.2 39489.8 39650.4 39905.4 40162.2 40471.2 9080.4 9182.4 9191.9 9232.8 9437.4 14803.6 14812.3 14824.9 14826.6 14842.8 6155.2 6278.3 6332.5 6454.8 6504.7 3634.9 3648.6 3706.8 3714.0 3730.1 2595.9 2605.4 2613.9 2626.6 2626.9 446.0 457.3 458.0 459.4 471.7 539.8 572.9 587.4 589.8 594.7 7412.5 7418.2 7595.0 7620.1 7733.2 461.3 561.7 590.6 604.2 606.8 3564.4 3580.4 3598.1 3673.6 3811.5 48361.3 48613.0 48711.3 49093.5 49145.3 44278.3 45081.3 45454.3 45487.5 45545.1 41032.4 41288.6 41651.8 41845.4 41975.0 7485.9 7518.7 7674.3 8196.6 8238.7 29922.4 30340.4 31206.0 31291.2 32212.4 39474.8 39512.8 39513.4 39904.4 39933.8 8966.0 9430.0 9815.9 10323.1 10501.2 10936.1 11049.8 11057.6 11156.3 11277.1 10238.6 10431.9 10442.7 10547.3 10724.6 9921.5 10106.6 10148.0 10318.8 10347.2 10271.8 10388.3 10511.9 10513.6 10698.0 8754.9 9049.3 9219.5 9752.6 9866.6 8452.7 8540.4 8602.9 8605.1 8980.7 07:56:08 INFO - 2015-12-14 07:56:08,327 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:56:08 INFO - 2015-12-14 07:56:08,327 DEBUG : BROWSER_OUTPUT: 07:56:09 INFO - 2015-12-14 07:56:09,117 INFO : Browser exited with error code: 0 07:56:09 INFO - 2015-12-14 07:56:09,138 INFO : Completed test dromaeo_css (00:18:36) 07:56:09 INFO - 2015-12-14 07:56:09,138 INFO : Starting test kraken 07:56:09 INFO - 2015-12-14 07:56:09,138 DEBUG : operating with platform_type : linux_ 07:56:09 INFO - 2015-12-14 07:56:09,138 INFO : Initialising browser for kraken test... 07:56:09 INFO - 2015-12-14 07:56:09,144 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEDosJl/profile http://localhost:33288/getInfo.html 07:56:13 INFO - 2015-12-14 07:56:13,438 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:56:13 INFO - 2015-12-14 07:56:13,438 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:56:13 INFO - 2015-12-14 07:56:13,438 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:56:13 INFO - 2015-12-14 07:56:13,438 DEBUG : BROWSER_OUTPUT: __metrics 07:56:13 INFO - 2015-12-14 07:56:13,535 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] 07:56:13 INFO - 2015-12-14 07:56:13,603 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] 07:56:13 INFO - 2015-12-14 07:56:13,954 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. 07:56:14 INFO - 2015-12-14 07:56:14,563 INFO : Browser initialized. 07:56:14 INFO - 2015-12-14 07:56:14,564 INFO : Running cycle 1/1 for kraken test... 07:56:14 INFO - 2015-12-14 07:56:14,564 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEDosJl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:56:26 INFO - 2015-12-14 07:56:26,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 140664832 07:56:26 INFO - 2015-12-14 07:56:26,600 DEBUG : BROWSER_OUTPUT: 07:56:29 INFO - 2015-12-14 07:56:29,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33288/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:29 INFO - 2015-12-14 07:56:29,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 177012736 07:56:29 INFO - 2015-12-14 07:56:29,802 DEBUG : BROWSER_OUTPUT: 07:56:32 INFO - 2015-12-14 07:56:32,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33288/tests/kraken/driver.html?testName=audio-dft) 07:56:33 INFO - 2015-12-14 07:56:33,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 166514688 07:56:33 INFO - 2015-12-14 07:56:33,101 DEBUG : BROWSER_OUTPUT: 07:56:36 INFO - 2015-12-14 07:56:36,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33288/tests/kraken/driver.html?testName=audio-fft) 07:56:36 INFO - 2015-12-14 07:56:36,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 151642112 07:56:36 INFO - 2015-12-14 07:56:36,658 DEBUG : BROWSER_OUTPUT: 07:56:38 INFO - 2015-12-14 07:56:38,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33288/tests/kraken/driver.html?testName=audio-oscillator) 07:56:39 INFO - 2015-12-14 07:56:39,264 DEBUG : BROWSER_OUTPUT: RSS: Main: 154001408 07:56:39 INFO - 2015-12-14 07:56:39,264 DEBUG : BROWSER_OUTPUT: 07:56:41 INFO - 2015-12-14 07:56:41,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:42 INFO - 2015-12-14 07:56:42,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 156082176 07:56:42 INFO - 2015-12-14 07:56:42,080 DEBUG : BROWSER_OUTPUT: 07:56:45 INFO - 2015-12-14 07:56:45,047 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33288/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:45 INFO - 2015-12-14 07:56:45,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 154427392 07:56:45 INFO - 2015-12-14 07:56:45,620 DEBUG : BROWSER_OUTPUT: 07:56:49 INFO - 2015-12-14 07:56:49,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33288/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:49 INFO - 2015-12-14 07:56:49,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 155250688 07:56:49 INFO - 2015-12-14 07:56:49,610 DEBUG : BROWSER_OUTPUT: 07:56:52 INFO - 2015-12-14 07:56:52,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33288/tests/kraken/driver.html?testName=json-parse-financial) 07:56:53 INFO - 2015-12-14 07:56:53,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 157138944 07:56:53 INFO - 2015-12-14 07:56:53,022 DEBUG : BROWSER_OUTPUT: 07:56:54 INFO - 2015-12-14 07:56:54,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:56:55 INFO - 2015-12-14 07:56:55,390 DEBUG : BROWSER_OUTPUT: RSS: Main: 165109760 07:56:55 INFO - 2015-12-14 07:56:55,390 DEBUG : BROWSER_OUTPUT: 07:56:57 INFO - 2015-12-14 07:56:57,309 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:56:57 INFO - 2015-12-14 07:56:57,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 165593088 07:56:57 INFO - 2015-12-14 07:56:57,911 DEBUG : BROWSER_OUTPUT: 07:57:00 INFO - 2015-12-14 07:57:00,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:00 INFO - 2015-12-14 07:57:00,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 179367936 07:57:00 INFO - 2015-12-14 07:57:00,665 DEBUG : BROWSER_OUTPUT: 07:57:03 INFO - 2015-12-14 07:57:03,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:03 INFO - 2015-12-14 07:57:03,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 184156160 07:57:03 INFO - 2015-12-14 07:57:03,800 DEBUG : BROWSER_OUTPUT: 07:57:06 INFO - 2015-12-14 07:57:06,500 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:07 INFO - 2015-12-14 07:57:07,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 182603776 07:57:07 INFO - 2015-12-14 07:57:07,081 DEBUG : BROWSER_OUTPUT: 07:57:08 INFO - 2015-12-14 07:57:08,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33288/tests/kraken/driver.html?testName=ai-astar) 07:57:09 INFO - 2015-12-14 07:57:09,128 DEBUG : BROWSER_OUTPUT: RSS: Main: 240320512 07:57:09 INFO - 2015-12-14 07:57:09,128 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,132 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:57:09 INFO - 2015-12-14 07:57:09,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:57:09 INFO - 2015-12-14 07:57:09,132 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:57:09 INFO - 2015-12-14 07:57:09,132 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;116;107;112;114;113;103;114;112;112 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;154;175;137;156;155;129;168;129 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;163;161;160;159;160;164;161;162;162 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;94;94;72;75;73;93;88;72 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;132;94;95;96;137;94;96;131 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;109;110;109;109;109 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;146;147;147;147;146;148 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;96;95 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;73;74;73;74;72;74;82;74;72 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;70;68;69;68;69;70 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;86;86;88;88;88;96;87;87;86 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;125;126;125;119;119;121;121;131;120 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;154;157;155;150;146;171;154;157;143 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;73;72;81;74;71;72;74;71;73 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:57:09 INFO - 2015-12-14 07:57:09,133 DEBUG : BROWSER_OUTPUT: __start_cc_report 07:57:09 INFO - 2015-12-14 07:57:09,134 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 07:57:09 INFO - 2015-12-14 07:57:09,134 DEBUG : BROWSER_OUTPUT: __end_cc_report 07:57:09 INFO - 2015-12-14 07:57:09,134 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108629131__endTimestamp 07:57:09 INFO - 2015-12-14 07:57:09,134 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: Number of tests: 14 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:113.50 stddev:3.86 (3.4%) stddev-sans-first:4.00 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: Values: 114.0 116.0 107.0 112.0 114.0 113.0 103.0 114.0 112.0 112.0 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.80 Median:155.50 stddev:16.80 (10.8%) stddev-sans-first:17.61 07:57:09 INFO - 2015-12-14 07:57:09,137 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 154.0 175.0 137.0 156.0 155.0 129.0 168.0 129.0 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: Values: 162.0 163.0 161.0 160.0 159.0 160.0 164.0 161.0 162.0 162.0 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.60 Median:81.50 stddev:10.20 (12.5%) stddev-sans-first:10.33 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 94.0 94.0 72.0 75.0 73.0 93.0 88.0 72.0 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:95.00 stddev:18.52 (19.5%) stddev-sans-first:19.17 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 132.0 94.0 95.0 96.0 137.0 94.0 96.0 131.0 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 148.0 07:57:09 INFO - 2015-12-14 07:57:09,138 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.30 Median:74.00 stddev:2.87 (3.9%) stddev-sans-first:3.03 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 74.0 73.0 74.0 72.0 74.0 82.0 74.0 72.0 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 70.0 68.0 69.0 68.0 69.0 70.0 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:88.00 stddev:2.94 (3.3%) stddev-sans-first:3.12 07:57:09 INFO - 2015-12-14 07:57:09,139 DEBUG : BROWSER_OUTPUT: Values: 88.0 86.0 86.0 88.0 88.0 88.0 96.0 87.0 87.0 86.0 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.50 Median:125.00 stddev:4.12 (3.3%) stddev-sans-first:4.03 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: Values: 128.0 125.0 126.0 125.0 119.0 119.0 121.0 121.0 131.0 120.0 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.20 Median:154.50 stddev:8.05 (5.2%) stddev-sans-first:7.98 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: Values: 145.0 154.0 157.0 155.0 150.0 146.0 171.0 154.0 157.0 143.0 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:73.00 stddev:2.97 (4.1%) stddev-sans-first:3.05 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: Values: 71.0 73.0 72.0 81.0 74.0 71.0 72.0 74.0 71.0 73.0 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:57:09 INFO - 2015-12-14 07:57:09,140 DEBUG : BROWSER_OUTPUT: 07:57:10 INFO - 2015-12-14 07:57:10,025 INFO : Browser exited with error code: 0 07:57:10 INFO - 2015-12-14 07:57:10,073 INFO : Completed test kraken (00:01:00) 07:57:10 INFO - 2015-12-14 07:57:10,073 INFO : Starting test v8_7 07:57:10 INFO - 2015-12-14 07:57:10,073 DEBUG : operating with platform_type : linux_ 07:57:10 INFO - 2015-12-14 07:57:10,073 INFO : Initialising browser for v8_7 test... 07:57:10 INFO - 2015-12-14 07:57:10,079 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFOVzb/profile http://localhost:33288/getInfo.html 07:57:14 INFO - 2015-12-14 07:57:14,322 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:57:14 INFO - 2015-12-14 07:57:14,322 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:57:14 INFO - 2015-12-14 07:57:14,322 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:57:14 INFO - 2015-12-14 07:57:14,322 DEBUG : BROWSER_OUTPUT: __metrics 07:57:14 INFO - 2015-12-14 07:57:14,430 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] 07:57:14 INFO - 2015-12-14 07:57:14,498 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] 07:57:15 INFO - 2015-12-14 07:57:15,348 INFO : Browser initialized. 07:57:15 INFO - 2015-12-14 07:57:15,349 INFO : Running cycle 1/1 for v8_7 test... 07:57:15 INFO - 2015-12-14 07:57:15,349 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbFOVzb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:57:27 INFO - 2015-12-14 07:57:27,333 DEBUG : BROWSER_OUTPUT: RSS: Main: 142032896 07:57:27 INFO - 2015-12-14 07:57:27,333 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33288/tests/v8_7/run.html (next: http://localhost:33288/tests/v8_7/run.html) 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 442810368 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: __start_tp_report 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 07:57:48 INFO - 2015-12-14 07:57:48,931 DEBUG : BROWSER_OUTPUT: |0;Richards;165.7000828500414 07:57:48 INFO - 2015-12-14 07:57:48,932 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.05574261129817 07:57:48 INFO - 2015-12-14 07:57:48,932 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.473962684489 07:57:48 INFO - 2015-12-14 07:57:48,932 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 07:57:48 INFO - 2015-12-14 07:57:48,932 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1960.7843137254902 07:57:48 INFO - 2015-12-14 07:57:48,932 DEBUG : BROWSER_OUTPUT: |5;Earley;787.4015748031496 07:57:48 INFO - 2015-12-14 07:57:48,932 DEBUG : BROWSER_OUTPUT: |6;Boyer;11952.380952380952 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: |7;RegExp;26368.42105263158 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: |8;Splay;604.5949214026602 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: __end_tp_report 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: __startTimestamp1450108668924__endTimestamp 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 07:57:48 INFO - 2015-12-14 07:57:48,933 DEBUG : BROWSER_OUTPUT: Number of tests: 10 07:57:48 INFO - 2015-12-14 07:57:48,934 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,934 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.70 Median:165.70 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,934 DEBUG : BROWSER_OUTPUT: Values: 165.7 07:57:48 INFO - 2015-12-14 07:57:48,934 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,934 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.06 Median:187.06 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,934 DEBUG : BROWSER_OUTPUT: Values: 187.1 07:57:48 INFO - 2015-12-14 07:57:48,935 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,935 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,935 DEBUG : BROWSER_OUTPUT: Values: 278.5 07:57:48 INFO - 2015-12-14 07:57:48,935 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: Values: 5186.5 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: Values: 1960.8 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,936 DEBUG : BROWSER_OUTPUT: Values: 787.4 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11952.38 Median:11952.38 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: Values: 11952.4 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26368.42 Median:26368.42 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: Values: 26368.4 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.59 Median:604.59 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: Values: 604.6 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: Values: 4830.9 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 07:57:48 INFO - 2015-12-14 07:57:48,937 DEBUG : BROWSER_OUTPUT: 07:57:49 INFO - 2015-12-14 07:57:49,817 INFO : Browser exited with error code: 0 07:57:49 INFO - 2015-12-14 07:57:49,831 INFO : Completed test v8_7 (00:00:39) 07:57:50 INFO - 2015-12-14 07:57:50,008 INFO : Completed test suite (00:20:17) 07:57:50 INFO - 2015-12-14 07:57:50,008 DEBUG : Working with test: dromaeo_css 07:57:50 INFO - 2015-12-14 07:57:50,008 DEBUG : Generating results file: dromaeo_css 07:57:50 INFO - 2015-12-14 07:57:50,009 DEBUG : Working with test: kraken 07:57:50 INFO - 2015-12-14 07:57:50,009 DEBUG : Generating results file: kraken 07:57:50 INFO - 2015-12-14 07:57:50,010 INFO : javascript benchmark 07:57:50 INFO - 2015-12-14 07:57:50,010 DEBUG : Working with test: v8_7 07:57:50 INFO - 2015-12-14 07:57:50,010 DEBUG : Generating results file: v8_7 07:57:50 INFO - 2015-12-14 07:57:50,010 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:50 INFO - 2015-12-14 07:57:50,070 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 07:57:50 INFO - 2015-12-14 07:57:50,070 DEBUG : process_Request line: dromaeo_css 6162.73 graph.html#tests=[[72,132,35]] 07:57:50 INFO - 2015-12-14 07:57:50,070 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:50 INFO - 2015-12-14 07:57:50,100 DEBUG : process_Request line: kraken 1541.70 graph.html#tests=[[232,132,35]] 07:57:50 INFO - 2015-12-14 07:57:50,100 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:57:50 INFO - 2015-12-14 07:57:50,149 DEBUG : process_Request line: v8_7 19908.67 graph.html#tests=[[230,132,35]] 07:57:50 INFO - 2015-12-14 07:57:50,150 INFO : javascript benchmark 07:57:50 INFO - 2015-12-14 07:57:50,154 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2559.270607876755, 2661.4677064587077, 2669.8665066746657, 2679.9464010719785, 2680.396910695093, 4516.254817955041, 4646.442426908768, 4675.906481870365, 4684.601808846248, 4716.221823399139, 4618.422697162855, 4644.187267228239, 4712.952870471294, 4718.551737584932, 4733.905321893569, 4326.459192600925, 4326.545712700176, 4327.913441731163, 4328.956710432887, 4352.586504282088, 4186.769727664977, 4377.496587892385, 4379.802908869108, 4440.467143942716, 4449.777511124431, 4235.745855248664, 4296.914061718748, 4304.870853874389, 4308.633766129883, 4330.090680957002, 4323.783810809447, 4343.2399330117105, 4360.738355698668, 4373.825046998117, 4413.3821265022925, 4147.543770185277, 4242.703010789246, 4328.9783551082355, 4345.9130817383475, 4394.516603173648, 4511.751853648048, 4524.909501809978, 4596.35651008859, 4611.054733779567, 4626.4910859805395, 5012.974935125338, 5026.29631851541, 5029.1953287473825, 5073.0, 5079.74601269935, 4824.565789079, 5049.5707864831165, 5049.974750126263, 5053.090443720129, 5061.746912654389, 4582.221022426195, 4613.423322084739, 4626.329182268552, 4626.676132670715, 4659.0, 5132.897342053138, 5189.325387699575, 5195.324607801037, 5203.479652034766, 5204.4535323791215, 4799.6400269979895, 4989.675671081368, 4990.575801056878, 4991.276264941564, 5005.3242812220615, 4935.259711043301, 4998.0, 5010.048090862724, 5020.874478138076, 5051.646384753032, 4979.551840334388, 4994.375703037121, 4995.650304478651, 4997.075541024922, 5041.949580504222, 4964.255361695702, 4965.875853103629, 4967.279744437036, 4967.925481117786, 5020.573251273682, 4001.7398869073418, 4070.5115386153852, 4105.261053010427, 4105.527864295585, 4106.993786522261, 3687.022938921188, 3709.4435834624483, 3709.703223742094, 3714.201446688975, 3716.4982727332003, 4253.361995700608, 4327.091310824762, 4327.870163895025, 4358.433403657505, 4370.584794444522, 5026.346574945307, 5033.496650334937, 5037.697738135724, 5039.0, 5040.042391945519, 4149.398337241083, 4252.319628859368, 4322.589354011364, 4324.935125973113, 4361.454818147731, 4326.891827704269, 4385.232584297735, 4412.757298348557, 4424.80088396023, 4467.374567560544, 4712.976435117803, 4716.5990890774665, 4723.291506274018, 4727.598154156866, 4788.640851936118, 4810.903781924412, 4923.926141107958, 4933.087378834927, 4982.227754698028, 5032.6225533084435, 4707.270373092176, 4729.905401891874, 4795.9280610790165, 4832.806687732592, 4859.441164266154, 4989.501049894981, 4995.300657907968, 5000.074986127578, 5003.4246061701915, 5038.546530812245, 4817.662763606654, 5062.974685126551, 5066.721330326867, 5069.8732531687, 5118.309028281284, 4779.904401911873, 4813.229883218668, 4829.13075646373, 4871.19625261842, 4916.336294600326, 4821.421429428491, 4831.830885918976, 4837.201861692782, 4838.7338696370625, 4879.829205977774, 4600.907981840412, 4717.268823332389, 4731.077439899186, 4735.266033764772, 4781.760911954458, 4671.205894997791, 4778.546038126373, 4830.396200474941, 4835.081334546425, 4845.3216549682365, 4798.712077275374, 4821.059893320768, 4823.2282834746275, 4823.2282834746275, 4864.221724524059], "unit": "ms", "name": "dojo.html", "value": 4585.685794889712}, {"lowerIsBetter": false, "replicates": [559.4098226371177, 573.2175580332847, 573.6357413042718, 580.2688612348439, 582.0977484898407, 27653.585196222048, 28223.85888070562, 28268.575971360446, 28303.575446368322, 28322.291942701417, 28305.0, 37210.441843372304, 38196.809015954954, 38228.61771382285, 38265.23469530608, 7926.40551958604, 8082.636281367352, 8082.919170808304, 8085.878711819328, 8087.676492940304, 7227.494075414723, 7862.606869656494, 7924.484908480959, 7981.6009199540085, 7981.9201807982045, 7194.280571942816, 10226.744331391701, 10530.31552949056, 10531.157507399428, 10532.15742740579, 10026.799464010715, 10151.340162889463, 10153.39079655223, 10160.288779785418, 10163.136133428667, 7277.126744790606, 7477.289657482531, 7482.401407887356, 9802.313838031341, 9943.651972180938, 37754.62245377539, 38616.227675446615, 38704.80647596744, 38766.80616596899, 38833.61166388328, 2900.912972610825, 2932.0763959352735, 2938.3241854373614, 3140.230643492336, 3594.939492849616, 27296.727032729617, 27397.863010685018, 27543.31141721473, 27822.0, 27865.164045078476, 3217.871285148615, 3296.126526470487, 3314.453115235983, 3343.732501399882, 3441.380551500729, 227254.0, 228693.0, 230521.0, 230775.0, 231082.0, 57401.0, 57544.71227643835, 57695.71152144212, 57815.0, 57933.4206657928, 62153.68923155355, 62378.68810656008, 62380.0, 62405.37594624086, 62455.0, 12825.102242843099, 12942.288174150512, 13223.867761322455, 13224.0, 13313.46746130144, 10336.844947325797, 10376.948115259376, 10421.739456513647, 10446.112080473093, 10455.477226138662, 19569.217231310588, 20048.198072077244, 20059.799402006083, 20083.297084601967, 20089.598208036048, 7832.0, 7922.405819563556, 7960.283574478325, 8065.0, 8078.313343365762, 806.4757907360146, 831.2269589282025, 847.559269180023, 851.7231899632644, 971.5385192033727, 26083.869580651975, 26449.53614843232, 26512.337191570365, 26704.8664756675, 26734.331641708723, 829.8423299573062, 900.2392977933636, 952.0289304908954, 997.870276864003, 999.9900000999897, 12499.687507812196, 12537.550979806987, 13101.148425352321, 13108.279044652445, 13263.005274604444, 271922.0, 276286.0, 276444.0, 276556.0, 277270.0, 46396.536034639896, 46715.29927051097, 46731.532684673395, 46914.061718765435, 46916.0, 1220.334917469981, 1235.6910772307103, 1238.8141778733082, 1249.2254802022621, 1370.6093763277418, 23715.56032469917, 24051.37244523446, 24504.873781554612, 24540.631890522014, 24602.55980968858, 38265.80867095647, 38590.80704596459, 38984.220315594095, 39004.41493377545, 39061.8046909775, 235246.0, 258855.0, 260351.0, 260510.0, 260673.0, 23990.28029159128, 28842.134735957956, 28860.7113928858, 29081.418371632873, 29422.11733647994, 33767.32465350728, 37065.62934370622, 37445.25109497849, 37466.812665937585, 37884.24231515409, 29954.400911982073, 31799.841000794848, 32011.0, 32148.839255804505, 32469.837650811594, 31270.843645782537, 38114.80942595269, 39003.41494877522, 40728.0, 41333.0, 38874.0, 39075.0, 39649.603503964594, 39741.40387894126, 40204.0, 27465.72534274632, 28792.84053696023, 30670.233244169074, 32875.67124328822, 36333.45499817452, 23747.16884909089, 23843.523129537658, 23896.610338965966, 23914.043438262273, 24238.0], "unit": "ms", "name": "ext.html", "value": 17087.433938115657}, {"lowerIsBetter": false, "replicates": [331.29434304930504, 333.60801058755953, 335.12866546977847, 335.23064566819147, 338.2693382294245, 12460.875391246085, 12798.808017879739, 14804.55586332409, 15256.313465894034, 16004.199790010496, 9489.762755931106, 9604.807903841918, 9649.903500964989, 9743.805123897535, 9891.653792117277, 4467.352233926087, 4587.2201725706545, 4598.195315819718, 4600.217962946291, 4600.332951722015, 3491.039964009892, 3602.477640742091, 5134.691918484884, 5289.047971365153, 5296.867578310535, 5234.084035293828, 5252.947470525303, 5255.343082114736, 5257.342832145981, 5266.7366631668265, 5124.692518448886, 5271.894562108736, 5278.762455689503, 5287.180487024518, 5291.100512912775, 5059.06407314648, 5078.4921507849285, 5098.0, 5104.03023425548, 5107.1828507439, 15148.788096952218, 19308.613827723508, 19751.506212344662, 19751.703724444145, 19866.70199947002, 1721.1396976858186, 1838.0442170071622, 1838.6966150585138, 1842.3551756885117, 1884.35931783193, 9016.18854303116, 9192.678256261066, 9305.395149315273, 11169.385683787388, 12607.936960315232, 1746.2229307957964, 1767.3902503636225, 1774.9290028398848, 1813.5466133466634, 1824.3705921457076, 54638.45361546413, 56055.71972140195, 57046.14430783541, 57399.42600573983, 58686.41313586852, 9449.716508504756, 9756.90243097574, 9799.314048016571, 9841.065098815601, 9879.75300617476, 12554.748905021848, 12652.557160499338, 12659.177153484994, 12672.80990785139, 12676.936615316865, 6388.744450222032, 6419.80740577774, 6434.453071488976, 6477.514186436036, 6626.0, 6214.098955651405, 6218.378162183745, 6228.065790131516, 6236.438720515175, 6247.656378899113, 4177.644900183518, 4225.154969006211, 4226.746395216235, 4233.894152646209, 4268.59448352406, 1612.6129728864987, 1665.600255938566, 1675.7737705409857, 1694.2375930830929, 1711.0, 796.2236819101446, 853.1255463150196, 916.9266458683289, 943.2227605913778, 963.5808423335872, 10281.074703276741, 15203.31585078652, 15603.765943510856, 15828.68342633164, 16615.50153495397, 346.7693983500994, 350.04088796697374, 356.59526437493633, 378.92042671038837, 384.4924699396825, 5150.742462876841, 5359.196120581944, 5430.104032834538, 5527.198556209408, 5539.529140023063, 480174.0, 480377.0, 502399.0, 508466.0, 509360.0, 74426.62786686032, 74485.62757186287, 74773.62613187009, 75086.62456687681, 75599.62200188964, 441.60255769806787, 442.2305188971167, 442.312204521965, 446.98659040228847, 447.57927548104027, 9261.814763704553, 9291.953540232256, 9382.10869967352, 9419.293552983416, 9452.858207126761, 31988.520172197903, 32255.193620158745, 32322.515162273055, 32659.836700816344, 33696.3260734779, 44426.11147776962, 44555.0, 44791.32813007873, 45747.31379029251, 46055.76972115118, 8955.104489550993, 9060.365774395728, 9212.170904618617, 9249.76875578089, 9293.0, 16158.353665853234, 16486.75269870977, 16497.505074847773, 16760.497185084467, 16785.32858685639, 13873.791893121814, 13947.232902190477, 14094.436222550983, 14220.288985550887, 14385.0, 13646.317684115953, 13776.793348099585, 13823.930880345533, 13970.860291396955, 13997.300134993005, 10946.343219406861, 12749.0, 14171.0, 14364.569062928129, 14529.491467798576, 8108.797280068045, 8451.535165565952, 8516.318694504549, 8536.871946920925, 8850.336224783296, 13831.723365532835, 13941.860581394056, 14023.368948397143, 14226.644333891736, 14736.2631868404], "unit": "ms", "name": "jquery.html", "value": 7583.798259639138}, {"lowerIsBetter": false, "replicates": [1428.1217051513322, 1670.908100054497, 1712.9314827406904, 1730.662520808442, 1737.9919646604963, 5789.884202315957, 6698.765543205989, 6900.5859648421065, 6917.06619606353, 6930.549514281568, 6866.107406037208, 7035.2612975637585, 7038.0, 7047.788566343018, 7048.0, 1687.9156042197903, 1718.9398371057016, 1721.208244207666, 2004.6892731626585, 2037.8573499854942, 1719.5701074731317, 1727.2572793698705, 1964.8329891959202, 2003.3088584438347, 2012.8490363222743, 2030.766461856883, 2033.7661168965537, 2038.5617092325147, 2039.7450318710162, 2040.2349119080345, 1916.1473144450724, 1977.0608960743675, 1979.792121827209, 1980.4454752669276, 1983.1868933737098, 2001.5296405344732, 2013.5268211970322, 2026.6048120616485, 2029.6448121578812, 2040.6530889748778, 6900.896486552706, 6950.721971121149, 6961.060256865309, 6969.895451568231, 6970.651467426608, 4071.3485842265095, 4089.2434899543678, 4117.649999750025, 4133.42132101506, 4143.02638879863, 2558.270892795544, 2608.6608740863758, 2610.8955641774305, 2649.0728245114246, 2649.3509090272814, 807.3379828540599, 810.0846043970275, 811.4644334739044, 837.995810020952, 862.6937437209825, 9054.592543335566, 9065.957414897239, 9067.818643627157, 9069.909300906973, 9076.68231611897, 3720.1443667956523, 3740.6446387593137, 3790.6209379061875, 3800.5439347278502, 3821.178446633987, 7932.0878099019355, 7951.324137448266, 7951.880721789178, 7952.880706789403, 7958.482698624571, 4152.792360382029, 4155.750654960712, 4173.749575025508, 4180.122174343361, 4180.435641188462, 3798.3922572388838, 3798.6581207691443, 3799.5630502492013, 3800.1639639279315, 3800.9239815204096, 3314.1880239341517, 3320.26954070109, 3345.5483509725877, 3362.36115138123, 3370.764046516769, 898.9775255618531, 899.8155378147464, 1004.9447280399502, 1056.2447849787438, 1065.3980501016902, 908.8000639859221, 909.1136142261374, 926.5552534783342, 958.5542722634009, 1167.3287859480663, 6555.6066636002, 6596.80209593713, 6628.0, 6630.270670226271, 6644.202695676453, 964.392432767352, 967.5549247346158, 976.2873102635116, 1062.5324857063022, 1070.4059247117768, 4827.324174615556, 4942.332785073969, 4949.628777841676, 4953.0, 4958.826441074545, 8016.639251233709, 8043.436959412785, 8314.501129932223, 8318.750437486886, 8322.084570697218, 8102.230288122737, 8185.3451723861945, 8193.139720329398, 8200.466969647074, 8208.0, 6329.841753956096, 6498.090267362573, 6528.151340325822, 6623.668816559153, 6639.834004149935, 6667.2666006738245, 6708.329167083448, 6717.361850624183, 6722.0, 6732.697028633821, 7301.4158867289425, 7454.701811927463, 7524.849503009799, 7572.318491335806, 7575.393968482618, 7539.962300188464, 7713.6143192841255, 7747.0, 7755.883661745192, 7808.648610812641, 5948.0, 6015.428534289235, 6017.518598512021, 6017.638941663514, 6020.789272375446, 6279.058141278662, 6423.0, 6456.386643268882, 6460.3862633049785, 6462.773802916875, 5199.0, 5484.561235101262, 6053.243344581927, 6183.196184496167, 6373.3945275198785, 5846.649201047951, 5953.434423729739, 5979.611325263844, 6079.756809727562, 6117.908231376444, 6200.875982480416, 6201.472874805692, 6218.595791273553, 6219.284782250099, 6222.471089957223, 5476.151196564539, 5900.173975643499, 5954.46409823118, 5954.880902382015, 5957.3744756799915, 5819.621724587888, 5841.299044114563, 5845.41545845429, 5860.150278209721, 5912.201852749824], "unit": "ms", "name": "mootools.html", "value": 3948.5877881020756}, {"lowerIsBetter": false, "replicates": [296.0570582694119, 302.7351067815661, 303.9042701549012, 305.0953921622389, 306.3887544349024, 5211.843644690656, 5270.868228294295, 5326.89346213076, 5347.144456886899, 5350.705711185883, 5193.818216362428, 5198.142306519419, 5210.296609957654, 5232.581393488521, 5236.31927849379, 3882.514685664292, 4091.488563929509, 4092.9386059209137, 4093.304138296482, 4096.160287141136, 4006.4390985262085, 4025.7383270087353, 4096.672266218696, 4099.631033207011, 4115.403266526352, 4042.73722208057, 4051.0682543015123, 4055.472788537486, 4056.290149223889, 4061.045654271244, 3830.80845957701, 3928.292907276689, 3942.172143849795, 4053.0, 4060.776657283863, 3564.6435356464403, 3591.299696559172, 3600.459931010343, 3602.7838329700303, 3610.7472476926628, 5043.873903152414, 5067.366579177603, 5069.69581825088, 5072.391313042422, 5098.59211263098, 4663.813447462097, 4672.3925889634465, 4673.415823022122, 4675.158471475133, 4682.3210634458155, 5371.409144994048, 5481.561475082024, 5493.450654934514, 5502.312210973629, 5521.613487055908, 3920.196359746245, 3922.235164142993, 3927.7446965947124, 3932.1545867638597, 3932.429797679349, 5767.307923049219, 5778.739956701958, 5783.248177736909, 5791.305043394819, 5791.507721843648, 4026.0, 4038.7778672172726, 4043.8180281887385, 4045.150518391171, 4045.615666511677, 3871.593482684334, 4095.3037983542868, 4095.365218391154, 4105.466289382421, 4106.589341065929, 4580.473245576734, 4585.358049873021, 4586.036932244199, 4587.197240482902, 4591.265397536378, 5500.50495455411, 5501.587380946365, 5503.284573005563, 5505.229267902497, 5508.338999320107, 1383.9100458470168, 1396.5600835736711, 1399.181478834893, 1403.059949833614, 1403.2983508245877, 926.0276709455045, 933.4772527384687, 948.061419194992, 949.4208532794989, 954.2461455450256, 4843.176659967814, 4850.5149485051215, 4853.174960256765, 4853.3447984522345, 4864.124457597666, 5674.460926212003, 5683.715814209356, 5690.886182276331, 5700.287464066992, 5721.399253078367, 4847.3698419205275, 4850.902981940412, 4852.441969173519, 4854.004928989549, 4867.537583929521, 2748.807583469178, 2924.5759364892397, 3052.114886682837, 3079.414911166871, 3084.629844418684, 5294.92057619136, 5306.044911915892, 5306.787728490895, 5324.281222035053, 5384.811531596375, 5858.5898987070495, 5895.941040589625, 5925.259342582177, 5925.466707996301, 5944.138099975479, 5422.810201642924, 5434.538064264502, 5475.616706830563, 5479.178123281539, 5485.396606373216, 5778.56660750437, 5781.046127389102, 5786.218860453785, 5786.913196302143, 5789.478946894799, 5517.0, 5609.467100625434, 5639.351474580311, 5640.717964101696, 5640.830775076754, 5477.890442191214, 5483.479069488551, 5486.039943009878, 5490.6431081979545, 5494.1758736189895, 3906.7851268180525, 3919.412088186795, 3923.136909879936, 3938.4486171935378, 3940.6650434712224, 5633.746481408429, 5758.856028599319, 5759.568032397503, 5770.384292398136, 5773.1051686988585, 5524.66851988882, 5533.059379905506, 5535.059039963136, 5535.944640553543, 5539.0, 5527.419620939743, 5528.9723551381985, 5529.364123125892, 5534.169874518854, 5542.612017158922, 5406.189071639285, 5407.729613519387, 5408.513233808976, 5413.756380962787, 5415.566754659539, 5445.945540544544, 5587.720613969204, 5588.133839254922, 5589.413111623384, 5592.189132575835, 5182.844514664566, 5302.522772950453, 5320.44135365781, 5430.809921652881, 5431.646942948696], "unit": "ms", "name": "prototype.html", "value": 4147.061389403973}, {"lowerIsBetter": false, "replicates": [596.58537316565, 598.9610675306104, 625.3652542669191, 660.2901880478487, 760.9961950190249, 11596.594119205829, 11776.11679124066, 11796.646100616985, 11805.645830625073, 11833.704157396069, 10262.846057309147, 11044.668659940215, 11094.389808560525, 11129.72175695608, 11158.665240042792, 624.0950621598678, 636.9140615251009, 804.3565147881671, 816.6651672814147, 819.1562690428838, 814.6944895664126, 815.0830315894618, 821.6138414944996, 822.0874828939902, 822.8560001999656, 658.6969993802857, 839.7102999465175, 845.9196376344238, 846.8772028055928, 846.8899043124416, 659.9769008084718, 832.854250506162, 847.9279261262739, 848.1179573243819, 848.5629900601195, 629.298332359416, 630.7193298981955, 630.9842253943642, 631.2393565753256, 631.3623240527055, 11314.773704525864, 11377.431128443544, 11404.486798094105, 11404.657860264206, 11405.087592992624, 10964.616238431616, 11229.550817967352, 11291.49188286529, 11343.489542970587, 11575.189736718434, 9460.90539094607, 9584.137427631547, 9599.040095990415, 9761.267904907161, 9781.16860066888, 3336.3160552086765, 3353.4634458486526, 3362.764606477523, 3385.627580966092, 3392.1519620094978, 39489.80255098735, 39650.405243921654, 39905.40141897874, 40162.19675606472, 40471.19057618831, 9080.364374493722, 9182.425439834506, 9191.862122068174, 9232.769180770534, 9437.386569872937, 14803.629909252355, 14812.259387030605, 14824.851751482563, 14826.62933426673, 14842.777358339634, 6155.230596175478, 6278.30938596754, 6332.461740751995, 6454.838629034218, 6504.739810407531, 3634.890953271406, 3648.5986541480415, 3706.79612621303, 3714.0343510686876, 3730.086128898383, 2595.8572278524484, 2605.4137818990953, 2613.8693065346656, 2626.645402870588, 2626.855522946218, 445.98216071356785, 457.320878495434, 458.0381199481063, 459.37754342865605, 471.6933992904571, 539.8299535646258, 572.8796952639909, 587.3744462147799, 589.8377946064867, 594.6848170469658, 7412.518186317872, 7418.221086785918, 7594.96202518995, 7620.123685776207, 7733.2266773323345, 461.33106994857593, 561.6667410924736, 590.6220019187723, 604.2235727090667, 606.7876243314804, 3564.3564356435745, 3580.445031020196, 3598.1184609770776, 3673.5959044505084, 3811.4663947047434, 48361.27458088131, 48613.0, 48711.26933095935, 49093.50906490961, 49145.26282105771, 44278.335824962654, 45081.32378014332, 45454.31818522725, 45487.54512454833, 45545.08909821785, 41032.38451423231, 41288.58711412847, 41651.7917410411, 41845.37231941523, 41974.99999999939, 7485.887711684438, 7518.736844210426, 7674.347680447225, 8196.59017049157, 8238.670453181805, 29922.401551969273, 30340.393192136475, 31206.0, 31291.217719557193, 32212.35575288528, 39474.80262598669, 39512.802435987636, 39513.407298891114, 39904.401433979096, 39933.80033099816, 8966.0, 9429.952850235704, 9815.852762208715, 10323.122534584645, 10501.212409069198, 10936.070434013198, 11049.779004419706, 11057.612983545538, 11156.330620162817, 11277.097832173571, 10238.641647542301, 10431.94784026075, 10442.738931526772, 10547.261691681508, 10724.571017159225, 9921.465838385908, 10106.646267380607, 10147.985201479793, 10318.793624127626, 10347.223958203014, 10271.845922311022, 10388.272820902464, 10511.94744026275, 10513.632022879163, 10698.0, 8754.949406071311, 9049.321300902327, 9219.539023048956, 9752.609895604097, 9866.605335786488, 8452.74641760748, 8540.359473039423, 8602.91397086021, 8605.096464871098, 8980.685676001309], "unit": "ms", "name": "yui.html", "value": 5629.160788379694}], "name": "dromaeo_css", "value": 6162.733298141733}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 116.0, 107.0, 112.0, 114.0, 113.0, 103.0, 114.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 154.0, 175.0, 137.0, 156.0, 155.0, 129.0, 168.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.8}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 161.0, 160.0, 159.0, 160.0, 164.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 94.0, 94.0, 72.0, 75.0, 73.0, 93.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 132.0, 94.0, 95.0, 96.0, 137.0, 94.0, 96.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 74.0, 73.0, 74.0, 72.0, 74.0, 82.0, 74.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 70.0, 68.0, 69.0, 68.0, 69.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 86.0, 88.0, 88.0, 88.0, 96.0, 87.0, 87.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.0}, {"lowerIsBetter": true, "replicates": [128.0, 125.0, 126.0, 125.0, 119.0, 119.0, 121.0, 121.0, 131.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.5}, {"lowerIsBetter": true, "replicates": [145.0, 154.0, 157.0, 155.0, 150.0, 146.0, 171.0, 154.0, 157.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.2}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 81.0, 74.0, 71.0, 72.0, 74.0, 71.0, 73.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 73.2}], "name": "kraken", "value": 1541.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.7000828500414], "unit": "score", "name": "Richards", "value": 213.04756999999998}, {"lowerIsBetter": false, "replicates": [187.05574261129817], "unit": "score", "name": "DeltaBlue", "value": 353.4668280000001}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [11952.380952380952], "unit": "score", "name": "Boyer", "value": 55.75985258964142}, {"lowerIsBetter": false, "replicates": [26368.42105263158], "unit": "score", "name": "RegExp", "value": 34.54833333333334}, {"lowerIsBetter": false, "replicates": [604.5949214026602], "unit": "score", "name": "Splay", "value": 134.78611399999997}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19908.670959412128}]} 07:57:50 INFO - RETURN: dromaeo_css: 6162.73 07:57:50 INFO - RETURN: kraken: 1541.70 07:57:50 INFO - RETURN: v8_7: 19908.67 07:57:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19908.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1541.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6162.73"}}} 07:57:50 INFO - Return code: 0 07:57:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:57:50 INFO - # TBPL SUCCESS # 07:57:50 INFO - Running post-action listener: _resource_record_post_action 07:57:50 INFO - Running post-run listener: _resource_record_post_run 07:57:51 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 509001728; Read time: 8; Write time: 340092 07:57:51 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 231694336; Read time: 0; Write time: 173116 07:57:51 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277307392; Read time: 8; Write time: 166976 07:57:51 INFO - Running post-run listener: _upload_blobber_files 07:57:51 INFO - Blob upload gear active. 07:57:51 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 07:57:51 INFO - Copying logs to upload dir... 07:57:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.583200 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-14 07:57:51.231242) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:51.234425) ========= 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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009874 build_url: 'https://queue.taskcluster.net/v1/task/Vr_4ugPARkOEIyIwWLVwng/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:51.284920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:51.285245) ========= 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=61fa6ed41387771909ec0f71000001b3-1450107359.695849-803975552 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-14 07:57:51.335125) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 07:57:51.335441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-14 07:57:51.335783) ========= ========= Total master_lag: 0.24 =========