builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-028 starttime: 1449166292.23 results: success (0) buildid: 20151203091434 builduid: cd7cbdf9a88e4af28b87300faf53a580 revision: 92aebcffdfa972709c86c56bd255b2c360ea3d17 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.229572) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.230082) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.230447) ========= 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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005011 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.255053) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.255848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.270182) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.270715) ========= 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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004561 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.323006) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.323666) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.324520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.325201) ========= 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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 10:11:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-03 10:11:33 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.509209) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.509961) ========= 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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019042 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.562174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:32.562977) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 92aebcffdfa972709c86c56bd255b2c360ea3d17 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 92aebcffdfa972709c86c56bd255b2c360ea3d17 --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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 10:11:33,879 truncating revision to first 12 chars 2015-12-03 10:11:33,879 Setting DEBUG logging. 2015-12-03 10:11:33,879 attempt 1/10 2015-12-03 10:11:33,879 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/92aebcffdfa9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 10:11:34,135 unpacking tar archive at: b2g-inbound-92aebcffdfa9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:33.140218) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:33.140692) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:33.152081) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:33.152718) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 10:11:33.153671) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-03 10:11:33.154354) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:11:34 INFO - MultiFileLogger online at 20151203 10:11:34 in /builds/slave/test 10:11:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 10:11:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:11:34 INFO - {'append_to_log': False, 10:11:34 INFO - 'base_work_dir': '/builds/slave/test', 10:11:34 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 10:11:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:11:34 INFO - 'branch': 'B2G-Inbound-Non-PGO', 10:11:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:11:34 INFO - 'config_files': ('talos/linux_config.py',), 10:11:34 INFO - 'default_actions': ('clobber', 10:11:34 INFO - 'read-buildbot-config', 10:11:34 INFO - 'download-and-extract', 10:11:34 INFO - 'populate-webroot', 10:11:34 INFO - 'create-virtualenv', 10:11:34 INFO - 'install', 10:11:34 INFO - 'run-tests'), 10:11:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:11:34 INFO - 'download_minidump_stackwalk': True, 10:11:34 INFO - 'download_symbols': 'ondemand', 10:11:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:11:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:11:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:11:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:11:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:11:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:11:34 INFO - 'installer_path': 'installer.exe', 10:11:34 INFO - 'log_level': 'info', 10:11:34 INFO - 'log_name': 'talos', 10:11:34 INFO - 'log_to_console': True, 10:11:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:11:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:11:34 INFO - 'opt_config_files': (), 10:11:34 INFO - 'pip_index': False, 10:11:34 INFO - 'sps_profile': False, 10:11:34 INFO - 'sps_profile_interval': 0, 10:11:34 INFO - 'suite': 'dromaeojs', 10:11:34 INFO - 'system_bits': '64', 10:11:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:11:34 INFO - 'title': 'talos-linux64-ix-028', 10:11:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:11:34 INFO - 'use_talos_json': True, 10:11:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:11:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:11:34 INFO - 'work_dir': 'build'} 10:11:34 INFO - ##### 10:11:34 INFO - ##### Running clobber step. 10:11:34 INFO - ##### 10:11:34 INFO - Running pre-action listener: _resource_record_pre_action 10:11:34 INFO - Running main action method: clobber 10:11:34 INFO - rmtree: /builds/slave/test/build 10:11:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:11:35 INFO - Running post-action listener: _resource_record_post_action 10:11:35 INFO - ##### 10:11:35 INFO - ##### Running read-buildbot-config step. 10:11:35 INFO - ##### 10:11:35 INFO - Running pre-action listener: _resource_record_pre_action 10:11:35 INFO - Running main action method: read_buildbot_config 10:11:35 INFO - Using buildbot properties: 10:11:35 INFO - { 10:11:35 INFO - "properties": { 10:11:35 INFO - "buildnumber": 202, 10:11:35 INFO - "product": "firefox", 10:11:35 INFO - "script_repo_revision": "production", 10:11:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:11:35 INFO - "repository": "", 10:11:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 10:11:35 INFO - "buildid": "20151203091434", 10:11:35 INFO - "slavename": "talos-linux64-ix-028", 10:11:35 INFO - "pgo_build": "False", 10:11:35 INFO - "basedir": "/builds/slave/test", 10:11:35 INFO - "project": "", 10:11:35 INFO - "platform": "ubuntu64_hw", 10:11:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:11:35 INFO - "slavebuilddir": "test", 10:11:35 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 10:11:35 INFO - "branch": "b2g-inbound", 10:11:35 INFO - "repo_path": "integration/b2g-inbound", 10:11:35 INFO - "stage_platform": "linux64", 10:11:35 INFO - "builduid": "cd7cbdf9a88e4af28b87300faf53a580", 10:11:35 INFO - "revision": "92aebcffdfa972709c86c56bd255b2c360ea3d17" 10:11:35 INFO - }, 10:11:35 INFO - "sourcestamp": { 10:11:35 INFO - "repository": "", 10:11:35 INFO - "hasPatch": false, 10:11:35 INFO - "project": "", 10:11:35 INFO - "branch": "b2g-inbound-linux64-talos", 10:11:35 INFO - "changes": [ 10:11:35 INFO - { 10:11:35 INFO - "category": null, 10:11:35 INFO - "files": [ 10:11:35 INFO - { 10:11:35 INFO - "url": null, 10:11:35 INFO - "name": "https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:11:35 INFO - } 10:11:35 INFO - ], 10:11:35 INFO - "repository": "", 10:11:35 INFO - "rev": "92aebcffdfa972709c86c56bd255b2c360ea3d17", 10:11:35 INFO - "who": "fdesre@mozilla.com", 10:11:35 INFO - "when": 1449165365, 10:11:35 INFO - "number": 6739948, 10:11:35 INFO - "comments": "Bug 1229620 - Replace #ifdefs in b2g/ code by AppConstants r=timdream", 10:11:35 INFO - "project": "", 10:11:35 INFO - "at": "Thu 03 Dec 2015 09:56:05", 10:11:35 INFO - "branch": "b2g-inbound-linux64-talos", 10:11:35 INFO - "revlink": "", 10:11:35 INFO - "properties": [ 10:11:35 INFO - [ 10:11:35 INFO - "buildid", 10:11:35 INFO - "20151203091434", 10:11:35 INFO - "Change" 10:11:35 INFO - ], 10:11:35 INFO - [ 10:11:35 INFO - "builduid", 10:11:35 INFO - "cd7cbdf9a88e4af28b87300faf53a580", 10:11:35 INFO - "Change" 10:11:35 INFO - ], 10:11:35 INFO - [ 10:11:35 INFO - "pgo_build", 10:11:35 INFO - "False", 10:11:35 INFO - "Change" 10:11:35 INFO - ] 10:11:35 INFO - ], 10:11:35 INFO - "revision": "92aebcffdfa972709c86c56bd255b2c360ea3d17" 10:11:35 INFO - } 10:11:35 INFO - ], 10:11:35 INFO - "revision": "92aebcffdfa972709c86c56bd255b2c360ea3d17" 10:11:35 INFO - } 10:11:35 INFO - } 10:11:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:11:35 INFO - Running post-action listener: _resource_record_post_action 10:11:35 INFO - ##### 10:11:35 INFO - ##### Running download-and-extract step. 10:11:35 INFO - ##### 10:11:35 INFO - Running pre-action listener: _resource_record_pre_action 10:11:35 INFO - Running main action method: download_and_extract 10:11:35 INFO - mkdir: /builds/slave/test/build/tests 10:11:35 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')]} 10:11:35 INFO - https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/test_packages.json 10:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/test_packages.json 10:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:11:35 INFO - Downloaded 1302 bytes. 10:11:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:11:35 INFO - Using the following test package requirements: 10:11:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:11:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'jsshell-linux-x86_64.zip'], 10:11:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:11:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:11:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:11:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:11:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:11:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:11:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:11:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:11:35 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')]} 10:11:35 INFO - https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:36 INFO - Downloaded 21793204 bytes. 10:11:36 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 10:11:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:11:36 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 10:11:37 INFO - Return code: 0 10:11:37 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 10:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:37 INFO - https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:38 INFO - Downloaded 21793204 bytes. 10:11:38 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 10:11:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:11:38 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 10:11:40 INFO - Return code: 0 10:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:40 INFO - https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:40 INFO - Downloaded 11132001 bytes. 10:11:40 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 10:11:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:11:40 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 10:11:41 INFO - Return code: 0 10:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:41 INFO - https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:11:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:11:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:11:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FUylA3uxTaO4NiZPVaEkdA/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 10:11:42 INFO - Downloaded 57680626 bytes. 10:11:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:11:42 INFO - mkdir: /builds/slave/test/properties 10:11:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:11:42 INFO - Writing to file /builds/slave/test/properties/build_url 10:11:42 INFO - Contents: 10:11:42 INFO - build_url:https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:11:42 INFO - Running post-action listener: _resource_record_post_action 10:11:42 INFO - Running post-action listener: set_extra_try_arguments 10:11:42 INFO - ##### 10:11:42 INFO - ##### Running populate-webroot step. 10:11:42 INFO - ##### 10:11:42 INFO - Running pre-action listener: _resource_record_pre_action 10:11:42 INFO - Running main action method: populate_webroot 10:11:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:11:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:11:42 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 10:11:42 INFO - '../fennec_ids.txt'], 10:11:42 INFO - 'tests': ['tcheck2']}, 10:11:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:11:42 INFO - '--tppagecycles', 10:11:42 INFO - '7'], 10:11:42 INFO - 'tests': ['tsvgm']}}, 10:11:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:11:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:11:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:11:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:11:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:11:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'tests': ['damp', 'tps']}, 10:11:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['damp', 'tps']}, 10:11:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:11:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:11:42 INFO - 'other': {'tests': ['a11yr', 10:11:42 INFO - 'ts_paint', 10:11:42 INFO - 'tpaint', 10:11:42 INFO - 'sessionrestore', 10:11:42 INFO - 'sessionrestore_no_auto_restore']}, 10:11:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['a11yr', 10:11:42 INFO - 'ts_paint', 10:11:42 INFO - 'tpaint', 10:11:42 INFO - 'sessionrestore', 10:11:42 INFO - 'sessionrestore_no_auto_restore']}, 10:11:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['a11yr', 10:11:42 INFO - 'ts_paint', 10:11:42 INFO - 'tpaint', 10:11:42 INFO - 'sessionrestore', 10:11:42 INFO - 'sessionrestore_no_auto_restore']}, 10:11:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['a11yr', 10:11:42 INFO - 'ts_paint', 10:11:42 INFO - 'tpaint', 10:11:42 INFO - 'sessionrestore', 10:11:42 INFO - 'sessionrestore_no_auto_restore']}, 10:11:42 INFO - 'other_l64': {'tests': ['a11yr', 10:11:42 INFO - 'ts_paint', 10:11:42 INFO - 'tpaint', 10:11:42 INFO - 'sessionrestore', 10:11:42 INFO - 'sessionrestore_no_auto_restore']}, 10:11:42 INFO - 'other_nol64': {'tests': ['a11yr', 10:11:42 INFO - 'ts_paint', 10:11:42 INFO - 'tpaint', 10:11:42 INFO - 'sessionrestore', 10:11:42 INFO - 'sessionrestore_no_auto_restore']}, 10:11:42 INFO - 'svgr': {'tests': ['tsvgx', 10:11:42 INFO - 'tsvgr_opacity', 10:11:42 INFO - 'tart', 10:11:42 INFO - 'tscrollx', 10:11:42 INFO - 'cart']}, 10:11:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['tsvgx', 10:11:42 INFO - 'tsvgr_opacity', 10:11:42 INFO - 'tart', 10:11:42 INFO - 'tscrollx', 10:11:42 INFO - 'cart']}, 10:11:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'tests': ['tp5o']}, 10:11:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'talos_options': ['--e10s'], 10:11:42 INFO - 'tests': ['tp5o']}, 10:11:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'talos_options': ['--xperf_path', 10:11:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:42 INFO - 'tests': ['tp5n']}, 10:11:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:11:42 INFO - 'talos_options': ['--e10s', 10:11:42 INFO - '--xperf_path', 10:11:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:11:42 INFO - 'tests': ['tp5n']}}, 10:11:42 INFO - 'talos.zip': {'path': '', 10:11:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:11:42 INFO - Running post-action listener: _resource_record_post_action 10:11:42 INFO - ##### 10:11:42 INFO - ##### Running create-virtualenv step. 10:11:42 INFO - ##### 10:11:42 INFO - Running pre-action listener: _resource_record_pre_action 10:11:42 INFO - Running main action method: create_virtualenv 10:11:42 INFO - Creating virtualenv /builds/slave/test/build/venv 10:11:42 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 10:11:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:11:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:11:42 INFO - Using real prefix '/usr' 10:11:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:11:43 INFO - Installing distribute.............................................................................................................................................................................................done. 10:11:45 INFO - Installing pip.................done. 10:11:45 INFO - Return code: 0 10:11:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:45 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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:11:45 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 10:11:45 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 10:11:45 INFO - Using env: {'DISPLAY': ':0', 10:11:45 INFO - 'HOME': '/home/cltbld', 10:11:45 INFO - 'LANG': 'en_US.UTF-8', 10:11:45 INFO - 'LANGUAGE': 'en_US:en', 10:11:45 INFO - 'LOGNAME': 'cltbld', 10:11:45 INFO - 'MAIL': '/var/mail/cltbld', 10:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:45 INFO - 'MOZ_NO_REMOTE': '1', 10:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:45 INFO - 'NO_EM_RESTART': '1', 10:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:45 INFO - 'PWD': '/builds/slave/test', 10:11:45 INFO - 'SHELL': '/bin/bash', 10:11:45 INFO - 'SHLVL': '1', 10:11:45 INFO - 'TERM': 'linux', 10:11:45 INFO - 'TMOUT': '86400', 10:11:45 INFO - 'USER': 'cltbld', 10:11:45 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:45 INFO - '_': '/tools/buildbot/bin/python'} 10:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:45 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 10:11:45 INFO - Cleaning up... 10:11:45 INFO - Return code: 0 10:11:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:45 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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:11:45 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 10:11:45 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 10:11:45 INFO - Using env: {'DISPLAY': ':0', 10:11:45 INFO - 'HOME': '/home/cltbld', 10:11:45 INFO - 'LANG': 'en_US.UTF-8', 10:11:45 INFO - 'LANGUAGE': 'en_US:en', 10:11:45 INFO - 'LOGNAME': 'cltbld', 10:11:45 INFO - 'MAIL': '/var/mail/cltbld', 10:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:45 INFO - 'MOZ_NO_REMOTE': '1', 10:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:45 INFO - 'NO_EM_RESTART': '1', 10:11:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:45 INFO - 'PWD': '/builds/slave/test', 10:11:45 INFO - 'SHELL': '/bin/bash', 10:11:45 INFO - 'SHLVL': '1', 10:11:45 INFO - 'TERM': 'linux', 10:11:45 INFO - 'TMOUT': '86400', 10:11:45 INFO - 'USER': 'cltbld', 10:11:45 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:45 INFO - '_': '/tools/buildbot/bin/python'} 10:11:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:45 INFO - Downloading/unpacking psutil>=0.7.1 10:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:11:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:11:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:11:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:47 INFO - Installing collected packages: psutil 10:11:47 INFO - Running setup.py install for psutil 10:11:47 INFO - building 'psutil._psutil_linux' extension 10:11:47 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 10:11:47 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 10:11:47 INFO - building 'psutil._psutil_posix' extension 10:11:47 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 10:11:47 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 10:11:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:11:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:11:47 INFO - Successfully installed psutil 10:11:47 INFO - Cleaning up... 10:11:48 INFO - Return code: 0 10:11:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:11: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')]} 10:11:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11: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')]} 10:11:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:48 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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:11:48 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 10:11:48 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 10:11:48 INFO - Using env: {'DISPLAY': ':0', 10:11:48 INFO - 'HOME': '/home/cltbld', 10:11:48 INFO - 'LANG': 'en_US.UTF-8', 10:11:48 INFO - 'LANGUAGE': 'en_US:en', 10:11:48 INFO - 'LOGNAME': 'cltbld', 10:11:48 INFO - 'MAIL': '/var/mail/cltbld', 10:11:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:48 INFO - 'MOZ_NO_REMOTE': '1', 10:11:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:48 INFO - 'NO_EM_RESTART': '1', 10:11:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:48 INFO - 'PWD': '/builds/slave/test', 10:11:48 INFO - 'SHELL': '/bin/bash', 10:11:48 INFO - 'SHLVL': '1', 10:11:48 INFO - 'TERM': 'linux', 10:11:48 INFO - 'TMOUT': '86400', 10:11:48 INFO - 'USER': 'cltbld', 10:11:48 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:11:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:48 INFO - '_': '/tools/buildbot/bin/python'} 10:11:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:11:48 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 10:11:48 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 10:11:48 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 10:11:48 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 10:11:48 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 10:11:48 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 10:11:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:11:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:11:49 INFO - Installing collected packages: mozsystemmonitor 10:11:49 INFO - Running setup.py install for mozsystemmonitor 10:11:50 INFO - Successfully installed mozsystemmonitor 10:11:50 INFO - Cleaning up... 10:11:50 INFO - Return code: 0 10:11:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:11:50 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 10:11:50 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 10:11:50 INFO - Using env: {'DISPLAY': ':0', 10:11:50 INFO - 'HOME': '/home/cltbld', 10:11:50 INFO - 'LANG': 'en_US.UTF-8', 10:11:50 INFO - 'LANGUAGE': 'en_US:en', 10:11:50 INFO - 'LOGNAME': 'cltbld', 10:11:50 INFO - 'MAIL': '/var/mail/cltbld', 10:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:50 INFO - 'MOZ_NO_REMOTE': '1', 10:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:50 INFO - 'NO_EM_RESTART': '1', 10:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:50 INFO - 'PWD': '/builds/slave/test', 10:11:50 INFO - 'SHELL': '/bin/bash', 10:11:50 INFO - 'SHLVL': '1', 10:11:50 INFO - 'TERM': 'linux', 10:11:50 INFO - 'TMOUT': '86400', 10:11:50 INFO - 'USER': 'cltbld', 10:11:50 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:50 INFO - '_': '/tools/buildbot/bin/python'} 10:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:50 INFO - Downloading/unpacking blobuploader==1.2.4 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:50 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 10:11:51 INFO - Downloading blobuploader-1.2.4.tar.gz 10:11:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:11:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:11:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 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 10:11:52 INFO - Downloading docopt-0.6.1.tar.gz 10:11:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 10:11:52 INFO - Running setup.py install for blobuploader 10:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:11:52 INFO - Running setup.py install for requests 10:11:53 INFO - Running setup.py install for docopt 10:11:53 INFO - Successfully installed blobuploader requests docopt 10:11:53 INFO - Cleaning up... 10:11:53 INFO - Return code: 0 10:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:53 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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:11:53 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 10:11:53 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 10:11:53 INFO - Using env: {'DISPLAY': ':0', 10:11:53 INFO - 'HOME': '/home/cltbld', 10:11:53 INFO - 'LANG': 'en_US.UTF-8', 10:11:53 INFO - 'LANGUAGE': 'en_US:en', 10:11:53 INFO - 'LOGNAME': 'cltbld', 10:11:53 INFO - 'MAIL': '/var/mail/cltbld', 10:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:53 INFO - 'MOZ_NO_REMOTE': '1', 10:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:53 INFO - 'NO_EM_RESTART': '1', 10:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:53 INFO - 'PWD': '/builds/slave/test', 10:11:53 INFO - 'SHELL': '/bin/bash', 10:11:53 INFO - 'SHLVL': '1', 10:11:53 INFO - 'TERM': 'linux', 10:11:53 INFO - 'TMOUT': '86400', 10:11:53 INFO - 'USER': 'cltbld', 10:11:53 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:53 INFO - '_': '/tools/buildbot/bin/python'} 10:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:53 INFO - Running setup.py (path:/tmp/pip-WHAO13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:53 INFO - Running setup.py (path:/tmp/pip-WBzFIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:53 INFO - Running setup.py (path:/tmp/pip-IsriW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:53 INFO - Running setup.py (path:/tmp/pip-7HpyO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:53 INFO - Running setup.py (path:/tmp/pip-VMLD07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:53 INFO - Running setup.py (path:/tmp/pip-rc6pdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:53 INFO - Running setup.py (path:/tmp/pip-J1Bpsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:53 INFO - Running setup.py (path:/tmp/pip-aMsCyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:54 INFO - Running setup.py (path:/tmp/pip-g8aQfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:54 INFO - Running setup.py (path:/tmp/pip-JVSV55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:54 INFO - Running setup.py (path:/tmp/pip-lxsotu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:54 INFO - Running setup.py (path:/tmp/pip-p4F9po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:54 INFO - Running setup.py (path:/tmp/pip-NWOuqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:54 INFO - Running setup.py (path:/tmp/pip-tAtW2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:54 INFO - Running setup.py (path:/tmp/pip-8UOYeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:54 INFO - Running setup.py (path:/tmp/pip-butSiV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:54 INFO - Running setup.py (path:/tmp/pip-KsGXfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:11:54 INFO - Running setup.py install for manifestparser 10:11:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:11:54 INFO - Running setup.py install for mozcrash 10:11:54 INFO - Running setup.py install for mozdebug 10:11:55 INFO - Running setup.py install for mozdevice 10:11:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozfile 10:11:55 INFO - Running setup.py install for mozhttpd 10:11:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozinfo 10:11:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozInstall 10:11:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozleak 10:11:55 INFO - Running setup.py install for mozlog 10:11:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for moznetwork 10:11:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:11:55 INFO - Running setup.py install for mozprocess 10:11:55 INFO - Running setup.py install for mozprofile 10:11:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Running setup.py install for mozrunner 10:11:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Running setup.py install for mozscreenshot 10:11:56 INFO - Running setup.py install for moztest 10:11:56 INFO - Running setup.py install for mozversion 10:11:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:11:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:11:56 INFO - Cleaning up... 10:11:56 INFO - Return code: 0 10:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:11:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:11:56 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 10:11:56 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 10:11:56 INFO - Using env: {'DISPLAY': ':0', 10:11:56 INFO - 'HOME': '/home/cltbld', 10:11:56 INFO - 'LANG': 'en_US.UTF-8', 10:11:56 INFO - 'LANGUAGE': 'en_US:en', 10:11:56 INFO - 'LOGNAME': 'cltbld', 10:11:56 INFO - 'MAIL': '/var/mail/cltbld', 10:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:11:56 INFO - 'MOZ_NO_REMOTE': '1', 10:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:11:56 INFO - 'NO_EM_RESTART': '1', 10:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:11:56 INFO - 'PWD': '/builds/slave/test', 10:11:56 INFO - 'SHELL': '/bin/bash', 10:11:56 INFO - 'SHLVL': '1', 10:11:56 INFO - 'TERM': 'linux', 10:11:56 INFO - 'TMOUT': '86400', 10:11:56 INFO - 'USER': 'cltbld', 10:11:56 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:11:56 INFO - '_': '/tools/buildbot/bin/python'} 10:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:11:56 INFO - Running setup.py (path:/tmp/pip-1vHBqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:11:56 INFO - Running setup.py (path:/tmp/pip-oUnLcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:11:56 INFO - Running setup.py (path:/tmp/pip-dHeFA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:11:56 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)) 10:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:11:56 INFO - Running setup.py (path:/tmp/pip-UEdNC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:11:57 INFO - Running setup.py (path:/tmp/pip-7jlH0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:11:57 INFO - Running setup.py (path:/tmp/pip-dsiUnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:11:57 INFO - Running setup.py (path:/tmp/pip-91z5wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:11:57 INFO - Running setup.py (path:/tmp/pip-Qd24Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:11:57 INFO - Running setup.py (path:/tmp/pip-3Lq7hO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:11:57 INFO - Running setup.py (path:/tmp/pip-NCGqGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:11:57 INFO - Running setup.py (path:/tmp/pip-bTKN2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:11:57 INFO - Running setup.py (path:/tmp/pip-MDVpE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:11:57 INFO - Running setup.py (path:/tmp/pip-5Wp4cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:11:57 INFO - Running setup.py (path:/tmp/pip-gAwa3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:57 INFO - Running setup.py (path:/tmp/pip-ZaaOWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:11:57 INFO - Running setup.py (path:/tmp/pip-Vvxi5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:11:57 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)) 10:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:11:57 INFO - Running setup.py (path:/tmp/pip-uezwrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 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)) 10:11:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:11:59 INFO - Downloading blessings-1.5.1.tar.gz 10:11:59 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 10:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:11:59 INFO - Installing collected packages: blessings 10:11:59 INFO - Running setup.py install for blessings 10:11:59 INFO - Successfully installed blessings 10:11:59 INFO - Cleaning up... 10:11:59 INFO - Return code: 0 10:11:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:00 INFO - Reading from file tmpfile_stdout 10:12:00 INFO - Current package versions: 10:12:00 INFO - argparse == 1.2.1 10:12:00 INFO - blessings == 1.5.1 10:12:00 INFO - blobuploader == 1.2.4 10:12:00 INFO - docopt == 0.6.1 10:12:00 INFO - manifestparser == 1.1 10:12:00 INFO - mozInstall == 1.12 10:12:00 INFO - mozcrash == 0.16 10:12:00 INFO - mozdebug == 0.1 10:12:00 INFO - mozdevice == 0.47 10:12:00 INFO - mozfile == 1.2 10:12:00 INFO - mozhttpd == 0.7 10:12:00 INFO - mozinfo == 0.9 10:12:00 INFO - mozleak == 0.1 10:12:00 INFO - mozlog == 3.1 10:12:00 INFO - moznetwork == 0.27 10:12:00 INFO - mozprocess == 0.22 10:12:00 INFO - mozprofile == 0.27 10:12:00 INFO - mozrunner == 6.11 10:12:00 INFO - mozscreenshot == 0.1 10:12:00 INFO - mozsystemmonitor == 0.0 10:12:00 INFO - moztest == 0.7 10:12:00 INFO - mozversion == 1.4 10:12:00 INFO - psutil == 3.1.1 10:12:00 INFO - requests == 1.2.3 10:12:00 INFO - wsgiref == 0.1.2 10:12:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', '-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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:12:00 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 10:12:00 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 10:12:00 INFO - Using env: {'DISPLAY': ':0', 10:12:00 INFO - 'HOME': '/home/cltbld', 10:12:00 INFO - 'LANG': 'en_US.UTF-8', 10:12:00 INFO - 'LANGUAGE': 'en_US:en', 10:12:00 INFO - 'LOGNAME': 'cltbld', 10:12:00 INFO - 'MAIL': '/var/mail/cltbld', 10:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:00 INFO - 'MOZ_NO_REMOTE': '1', 10:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:00 INFO - 'NO_EM_RESTART': '1', 10:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:00 INFO - 'PWD': '/builds/slave/test', 10:12:00 INFO - 'SHELL': '/bin/bash', 10:12:00 INFO - 'SHLVL': '1', 10:12:00 INFO - 'TERM': 'linux', 10:12:00 INFO - 'TMOUT': '86400', 10:12:00 INFO - 'USER': 'cltbld', 10:12:00 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:00 INFO - '_': '/tools/buildbot/bin/python'} 10:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 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)) 10:12:00 INFO - Cleaning up... 10:12:00 INFO - Return code: 0 10:12:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:12: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')]} 10:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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')]} 10:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:12: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', 'jsonschema'] in /builds/slave/test/build 10:12: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 jsonschema 10:12:00 INFO - Using env: {'DISPLAY': ':0', 10:12:00 INFO - 'HOME': '/home/cltbld', 10:12:00 INFO - 'LANG': 'en_US.UTF-8', 10:12:00 INFO - 'LANGUAGE': 'en_US:en', 10:12:00 INFO - 'LOGNAME': 'cltbld', 10:12:00 INFO - 'MAIL': '/var/mail/cltbld', 10:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:00 INFO - 'MOZ_NO_REMOTE': '1', 10:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:00 INFO - 'NO_EM_RESTART': '1', 10:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:00 INFO - 'PWD': '/builds/slave/test', 10:12:00 INFO - 'SHELL': '/bin/bash', 10:12:00 INFO - 'SHLVL': '1', 10:12:00 INFO - 'TERM': 'linux', 10:12:00 INFO - 'TMOUT': '86400', 10:12:00 INFO - 'USER': 'cltbld', 10:12:00 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:00 INFO - '_': '/tools/buildbot/bin/python'} 10:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:00 INFO - Downloading/unpacking jsonschema 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:12:02 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 10:12:02 INFO - Downloading/unpacking functools32 (from jsonschema) 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:02 INFO - Downloading functools32-3.2.3-2.tar.gz 10:12:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:12:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:12:02 INFO - warning: no files found matching '*.txt' 10:12:02 INFO - no previously-included directories found matching 'build' 10:12:02 INFO - no previously-included directories found matching 'dist' 10:12:02 INFO - no previously-included directories found matching '.git*' 10:12:02 INFO - Installing collected packages: jsonschema, functools32 10:12:02 INFO - Running setup.py install for functools32 10:12:02 INFO - warning: no files found matching '*.txt' 10:12:02 INFO - no previously-included directories found matching 'build' 10:12:02 INFO - no previously-included directories found matching 'dist' 10:12:02 INFO - no previously-included directories found matching '.git*' 10:12:02 INFO - Successfully installed jsonschema functools32 10:12:02 INFO - Cleaning up... 10:12:02 INFO - Return code: 0 10:12:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:12:02 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 0x7f36f40f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1593240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, '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': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', '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 10:12:02 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 10:12:02 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 10:12:02 INFO - Using env: {'DISPLAY': ':0', 10:12:02 INFO - 'HOME': '/home/cltbld', 10:12:02 INFO - 'LANG': 'en_US.UTF-8', 10:12:02 INFO - 'LANGUAGE': 'en_US:en', 10:12:02 INFO - 'LOGNAME': 'cltbld', 10:12:02 INFO - 'MAIL': '/var/mail/cltbld', 10:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:02 INFO - 'MOZ_NO_REMOTE': '1', 10:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:02 INFO - 'NO_EM_RESTART': '1', 10:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:02 INFO - 'PWD': '/builds/slave/test', 10:12:02 INFO - 'SHELL': '/bin/bash', 10:12:02 INFO - 'SHLVL': '1', 10:12:02 INFO - 'TERM': 'linux', 10:12:02 INFO - 'TMOUT': '86400', 10:12:02 INFO - 'USER': 'cltbld', 10:12:02 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:02 INFO - '_': '/tools/buildbot/bin/python'} 10:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:12:02 INFO - Downloading/unpacking flake8 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12: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 10:12:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:12:04 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 10:12:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:12:04 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 10:12:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:04 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 10:12:05 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 10:12:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:12:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:12:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:05 INFO - no previously-included directories found matching 'docs/_build' 10:12:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:12:05 INFO - Running setup.py install for pep8 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:12:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:12:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:12:05 INFO - no previously-included directories found matching 'docs/_build' 10:12:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:12:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:12:05 INFO - Cleaning up... 10:12:05 INFO - Return code: 0 10:12:05 INFO - Running post-action listener: _resource_record_post_action 10:12:05 INFO - Running post-action listener: _start_resource_monitoring 10:12:05 INFO - Starting resource monitoring. 10:12:05 INFO - ##### 10:12:05 INFO - ##### Running install step. 10:12:05 INFO - ##### 10:12:05 INFO - Running pre-action listener: _resource_record_pre_action 10:12:05 INFO - Running main action method: install 10:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:12:05 INFO - Reading from file tmpfile_stdout 10:12:05 INFO - Detecting whether we're running mozinstall >=1.0... 10:12:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:12:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:12:05 INFO - Reading from file tmpfile_stdout 10:12:05 INFO - Output received: 10:12:05 INFO - Usage: mozinstall [options] installer 10:12:05 INFO - Options: 10:12:05 INFO - -h, --help show this help message and exit 10:12:05 INFO - -d DEST, --destination=DEST 10:12:05 INFO - Directory to install application into. [default: 10:12:05 INFO - "/builds/slave/test"] 10:12:05 INFO - --app=APP Application being installed. [default: firefox] 10:12:05 INFO - mkdir: /builds/slave/test/build/application 10:12:05 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'] 10:12:05 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 10:12:20 INFO - Reading from file tmpfile_stdout 10:12:20 INFO - Output received: 10:12:20 INFO - /builds/slave/test/build/application/firefox/firefox 10:12:20 INFO - Running post-action listener: _resource_record_post_action 10:12:20 INFO - ##### 10:12:20 INFO - ##### Running run-tests step. 10:12:20 INFO - ##### 10:12:20 INFO - Running pre-action listener: _resource_record_pre_action 10:12:20 INFO - Running main action method: run_tests 10:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:12:20 INFO - Python 2.7.3 10:12:20 INFO - Return code: 0 10:12:20 INFO - grabbing minidump binary from tooltool 10:12:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:12:20 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 0x16220b0>, '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 0x1622fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1623440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:12:20 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 10:12:20 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 10:12:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:12:20 INFO - Return code: 0 10:12:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:12:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:12:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:12:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:12:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:12:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:12:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:12:21 INFO - Return code: 0 10:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test/build 10:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 10:12:21 INFO - Using env: {'DISPLAY': ':0', 10:12:21 INFO - 'HOME': '/home/cltbld', 10:12:21 INFO - 'LANG': 'en_US.UTF-8', 10:12:21 INFO - 'LANGUAGE': 'en_US:en', 10:12:21 INFO - 'LOGNAME': 'cltbld', 10:12:21 INFO - 'MAIL': '/var/mail/cltbld', 10:12:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:12:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:12:21 INFO - 'MOZ_NO_REMOTE': '1', 10:12:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:12:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:12:21 INFO - 'NO_EM_RESTART': '1', 10:12:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:12:21 INFO - 'PWD': '/builds/slave/test', 10:12:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:12:21 INFO - 'SHELL': '/bin/bash', 10:12:21 INFO - 'SHLVL': '1', 10:12:21 INFO - 'TERM': 'linux', 10:12:21 INFO - 'TMOUT': '86400', 10:12:21 INFO - 'USER': 'cltbld', 10:12:21 INFO - 'XDG_SESSION_COOKIE': 'b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843', 10:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:12:21 INFO - '_': '/tools/buildbot/bin/python'} 10:12:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 10:12:21 INFO - mozversion INFO | application_buildid: 20151203091434 10:12:21 INFO - mozversion INFO | application_changeset: 92aebcffdfa972709c86c56bd255b2c360ea3d17 10:12:21 INFO - mozversion INFO | application_display_name: Nightly 10:12:21 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:12:21 INFO - mozversion INFO | application_name: Firefox 10:12:21 INFO - mozversion INFO | application_remotingname: firefox 10:12:21 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 10:12:21 INFO - mozversion INFO | application_vendor: Mozilla 10:12:21 INFO - mozversion INFO | application_version: 45.0a1 10:12:21 INFO - mozversion INFO | platform_buildid: 20151203091434 10:12:21 INFO - mozversion INFO | platform_changeset: 92aebcffdfa972709c86c56bd255b2c360ea3d17 10:12:21 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 10:12:21 INFO - mozversion INFO | platform_version: 45.0a1 10:12:21 INFO - 2015-12-03 10:12:21,574 DEBUG : using testdate: 1449166341 10:12:21 INFO - 2015-12-03 10:12:21,574 DEBUG : actual date: 1449166341 10:12:21 INFO - 2015-12-03 10:12:21,622 INFO : starting webserver on 'localhost:42867' 10:12:21 INFO - 2015-12-03 10:12:21,623 INFO : Starting test suite talos-linux64-ix-028 10:12:21 INFO - 2015-12-03 10:12:21,623 INFO : Starting test dromaeo_css 10:12:21 INFO - 2015-12-03 10:12:21,623 DEBUG : operating with platform_type : linux_ 10:12:21 INFO - 2015-12-03 10:12:21,624 INFO : Initialising browser for dromaeo_css test... 10:12:21 INFO - 2015-12-03 10:12:21,640 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGrlrm/profile http://localhost:42867/getInfo.html 10:12:25 INFO - 2015-12-03 10:12:25,883 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:12:25 INFO - 2015-12-03 10:12:25,883 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:12:25 INFO - 2015-12-03 10:12:25,883 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:12:25 INFO - 2015-12-03 10:12:25,883 DEBUG : BROWSER_OUTPUT: __metrics 10:12:25 INFO - 2015-12-03 10:12:25,967 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:12:25 INFO - 2015-12-03 10:12:25,969 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:12:26 INFO - 2015-12-03 10:12:26,960 INFO : Browser initialized. 10:12:26 INFO - 2015-12-03 10:12:26,960 INFO : Running cycle 1/1 for dromaeo_css test... 10:12:26 INFO - 2015-12-03 10:12:26,961 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGGrlrm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:12:38 INFO - 2015-12-03 10:12:38,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 144048128 10:12:38 INFO - 2015-12-03 10:12:38,978 DEBUG : BROWSER_OUTPUT: 10:13:30 INFO - 2015-12-03 10:13:30,167 DEBUG : BROWSER_OUTPUT: 1449166410166 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] 10:15:42 INFO - 2015-12-03 10:15:42,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42867/tests/dromaeo/cssquery-ext.html) 10:15:43 INFO - 2015-12-03 10:15:43,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 255168512 10:15:43 INFO - 2015-12-03 10:15:43,268 DEBUG : BROWSER_OUTPUT: 10:18:45 INFO - 2015-12-03 10:18:45,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/dromaeo/cssquery-ext.html (next: http://localhost:42867/tests/dromaeo/cssquery-jquery.html) 10:18:46 INFO - 2015-12-03 10:18:46,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 227336192 10:18:46 INFO - 2015-12-03 10:18:46,345 DEBUG : BROWSER_OUTPUT: 10:21:48 INFO - 2015-12-03 10:21:48,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42867/tests/dromaeo/cssquery-mootools.html) 10:21:48 INFO - 2015-12-03 10:21:48,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 224567296 10:21:48 INFO - 2015-12-03 10:21:48,984 DEBUG : BROWSER_OUTPUT: 10:24:51 INFO - 2015-12-03 10:24:51,040 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42867/tests/dromaeo/cssquery-prototype.html) 10:24:51 INFO - 2015-12-03 10:24:51,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 204689408 10:24:51 INFO - 2015-12-03 10:24:51,621 DEBUG : BROWSER_OUTPUT: 10:27:54 INFO - 2015-12-03 10:27:54,458 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42867/tests/dromaeo/cssquery-yui.html) 10:27:55 INFO - 2015-12-03 10:27:55,040 DEBUG : BROWSER_OUTPUT: RSS: Main: 204861440 10:27:55 INFO - 2015-12-03 10:27:55,040 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/dromaeo/cssquery-yui.html (next: http://localhost:42867/tests/dromaeo/cssquery-dojo.html) 10:30:57 INFO - 2015-12-03 10:30:57,779 DEBUG : BROWSER_OUTPUT: RSS: Main: 253747200 10:30:57 INFO - 2015-12-03 10:30:57,779 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,781 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:30:57 INFO - 2015-12-03 10:30:57,781 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:30:57 INFO - 2015-12-03 10:30:57,781 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:30:57 INFO - 2015-12-03 10:30:57,781 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:30:57 INFO - 2015-12-03 10:30:57,781 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2599.07732754872;2683.141394753677;2686.9462610747773;2698.5817198334266;2711.7288271172883;4538.047010127877;4625.629949604032;4659.650526210535;4661.5804577588015;4697.8120875165;4590.219662657348;4594.150082234789;4653.208954477738;4657.278121891104;4660.906781864361;4278.679099067567;4295.205387003399;4351.477822661285;4413.0732546165345;4443.333499974998;4135.77253251071;4351.347297905308;4379.846705365313;4423.181711383404;4476.910461790762;4182.226288136704;4264.189803937257;4290.613844753956;4301.892452688677;4307;4265.168292183025;4312.137572485484;4315.05068884848;4345.196138714348;4349.826006959749;4064.959350406488;4263.72285801425;4270.6156445919705;4281.4521872961095;4321.697481176319;4558.361829343895;4574.268117101281;4581.5647513486165;4591.219492686251;4594.65540084495;5020.3724534433195;5071.3407257056715;5073.771680274396;5075.061113693979;5100.897982040338;5036.370453693288;5048.178566631653;5051.772670229849;5057.974710126426;5078.365204349457;4441.888952776174;4549.45406551216;4549.863504094882;4593.6095431888;4665.370175026362;5104.03023425548;5108.438071812097;5116.130257856174;5120.078385890501;5156.097682905476;4893.09477746618;4908.361912951294;4915.631327650369;4926.605871530269;4961.578265847371;4856.514348565115;4914.827981020647;4942;4946.826861059845;5001.274815151783;4958.330625365529;4980.501949805063;4998.300237966688;5001.774920128603;5021.548060674557;4979.551840334388;4984.576311013604;4985.052839960396;4986.750662466862;5017.397912250553;4018.557958624549;4051.756894586334;4089.89775255621;4128.380742888591;4215.768132752667;3664.9633503664622;3681.1533347330264;3691.6492933171307;3694.8891533254045;3706.6293370663257;4339.609435150852;4341.674374421931;4343.609075183249;4359.280718681445;4373.825046998148;4820.831270905502;4930.605551555938;4939.456659767423;4985.152524070917;4998.850034498971;4295.677824163137;4297.269464191095;4300.03249268912;4317.805698743564;4317.805698743564;4419.756913369732;4444.844430444984;4446.955530444654;4447.644188464915;4471.619912307425;4584.358189853423;4711.575958163645;4717.245240761462;4722.268048452495;4817.0365926814775;5019.623528235324;5042.621803364689;5042.899142017212;5045.192769156917;5073.619478539198;4765.690230135169;4767.523247675204;4768.785404656868;4782.832600858953;4814.542618451242;4722.220833562561;4821.011692603078;4829.5653391194965;4895.926561101657;5001.924971125363;4988.276699878425;4989.625778066732;4991.101601711727;4995.225740010304;5051.924221136759;4815.374001379798;4816.54242846929;4817.156997525489;4832.420109586872;4866.537678920497;4646.86059418218;4698.459677137173;4778.331033655221;4781.5935645469135;4871.975640121776;4756.6908150970075;4776.450708168605;4800.879978000578;4814.15752243349;4857.975710121426;4876.073546026244;4909.803607855646;4925.433575138905;4929.580985616263;4965.255211718271;4622.815087396467;4715.528447155257;4750.216214324598;4757.785899634594;4815.235675616622 10:30:57 INFO - 2015-12-03 10:30:57,782 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.9577781666374;568.5309619563861;568.9402612725663;570.9864989643384;573.7045421607872;27141.592876106875;27661.723382766166;35195.120121996966;35665.46501802468;35675.2864942701;38593.8070309648;38916.80541597288;39110.8044459778;39114.413283800764;39194.21611567767;6952.617606031667;7929.960350198241;8066.4353495255355;8092.959535202316;8092.959535202316;6841.657917104125;6891.276415976326;6895.896561551581;6898.965505172467;10344.482775861214;10252.128569071638;10353.482325883713;10360.740981475448;10362.637307694233;10371.222158338154;10194.133498652587;10292.073713365833;10297.948510257476;10300.536475858604;10307.845382319309;7153.785386438363;7285.0165227694115;10374.273800833944;10634.255602107856;10652.41411722355;36503.817480912694;36769.26461470756;36867.81566092179;37056.814715926244;37128;2769.404578015736;2867.4981878171443;2889.4516111379107;2921.985390073036;2953.040261914865;27326;27326.726732732815;28049;29849.10452686423;30078.003120124675;3207.85564649589;3218.4593962902277;3234.272288735039;3276.836158192081;3278.1804548862783;216689;217695;217761.91119044463;217993;218446;54520.45479545154;54842.451575483734;54902.725486372314;54909;54976.17535736967;53586;54722;58001.12998305029;59483.70258148682;59490.405095949354;12818.871811281768;12949.741005179843;12982.805257921138;12999.09006369564;13056.934715326362;9851.064148905842;9932.702018939442;9958.053984871425;9980.051895069957;9981.251406144569;18047.729284060748;18297.817021829876;18300.267989280546;18910.905445472683;19109.235630574898;7339.77980660581;7551.433642476836;7629.160792312841;7634.8091297718;7708.653110610036;860.8149247911729;898.2679116520015;922.9907700922905;928.7445952363154;1028.6605420211313;25560.360990975;25970.610440843404;26246.86876565605;26292.342691432485;26343.47313053728;947.9289053321029;971.4705485510414;974.2011550528499;1046.1108058150662;1132.1452303510962;14925.70148597022;16043.759343609856;16053.117078560557;16057;16289.266982985793;318283;323522;323800;323929;324187;46612.3008154878;46981.765091174326;47157.76421117873;47243;47269.76365118221;1209.1656756837754;1221.6029790318182;1237.3256575166556;1240.8573014103313;1241.1622155045309;26757;27565.586516202675;27622.309442264104;28091.157265282076;28127.859360703886;38434.42348364833;38789;38804.6119538801;38895.41656875092;38961;238039;244896;251328;296034;301251;26809.865950670122;26813.195604131906;26816.329591759582;26837.463250735265;27188.592171117052;34020.1494962618;34184.82907585446;34754.478682820285;35035.64964350324;35127.47308790319;31762.841185793925;31899.36201276008;31954.84022579872;32779.836100819346;32904.34191316112;31939.201519961258;32423;32619.673803261663;32666.836665816518;32728.836355818068;32523.67476325301;32621.347573047933;32684.34631307313;32857.835710821295;34892.30215395729;26422.53409215095;29194.854025729735;30395.392092157592;30640.097584386393;30694.693053070077;23835;23891.67093504961;23902.16342428007;24248.515029698956;24445.38886527851 10:30:57 INFO - 2015-12-03 10:30:57,783 DEBUG : BROWSER_OUTPUT: |2;jquery.html;323.20169182120156;329.7218588810188;330.7337593237444;333.79471624950656;335.1019268360792;12245.32650704211;12594.244345339263;14527.636809079779;14956.5513034609;16109.677806443864;14149.787753183711;14710;14886.553403397915;15400.229988500587;15447.918645694806;4999.800007999685;5195;6052.334243233241;6232.096346029823;6245.875082498347;3902.356111241642;4014.6386825185728;6328.462080723144;6439.227292724856;6689.8662026759675;6460.515461340418;6574.737010519598;6590.538662293641;6646;6646.501512386566;6561.868762624745;6584.440322572587;6600.867982640344;6610.900836487408;6614.437772789294;6149.907751383733;6306.968465157691;6309.400606942333;6317.6209427434505;6325.715342809539;18944.336948206885;19045.142968566448;19654;20338.49153771153;20782.376528704164;1959.4415591556337;1986.8112529309692;2043.5606344635974;2087.749470063602;2120.2261174671135;12840.1011929165;12925.741485170338;13055.412506437233;13355.532556360578;13487.258200798951;1803.1525183164024;1895.4029480713532;1896.6680830854546;1916.6358391905494;1936.5061909213061;57704.42295577032;61505.692471537805;61569.7686046281;61783.38216617821;62484.687576561824;15174.544763657108;15177.392904283704;15195.164265965477;15201.771973420407;15350;22345.88827055887;22571.548569028528;22604.208852690077;22646.433839154153;22691.886540567193;7954.721584744506;7979.880301795478;7994.6002699864775;8060.15368386311;8100.797480062928;6790.59256444605;6828.5902845829405;6856.074429951992;6897.172339319314;6907.620080895498;6483.7082331295205;7495.812604684927;7527.510711803715;7529.8117547061765;7544.8491030180185;1659.8423149800992;2072.492239401326;2423.503181847717;2909.898153564615;2959.8224106553675;507.79434329096773;842.5071333270106;905.2531661379256;948.9240860731124;950.2350607760819;12877.806832897513;14866.554003379915;14912.776308355384;15525.534233973;15797.842021579867;827.3587969323702;842.1704620948483;848.809017970964;869.9521526315987;877.6664867350366;8224.62989165489;8871;8981.775455613662;9034.277257819358;9250.86123708145;307986;312384;313827;314645;461932;60906.69546652238;73382.6330868353;73395.26604733992;73809.26190738023;73995.63002184955;1002.8044531316323;1026.5688410867454;1027.4708525109575;1034.2863424237253;1046.6389095762102;13695.452181912611;14009.509667161601;14043.929780351033;14440.855591443951;14581.85418145805;29289.560656589743;30027.69972300249;30049.69950300469;30151.547726784556;30418.087457376314;39907;40122.79938600288;40680.38979415252;40705.79647101746;41147.55983540562;8850.336224783296;9287;9349.205317548085;9378.859317110113;9388.906110939077;14962;15157.848421516084;16239.59401014984;16246.431374901822;16750.162491875602;10247.846282305622;12983.221006739626;13222.735545288848;13260.204387736767;13443.932780336036;12864;12874.67813304675;12958.22250664963;12987;13072.673183170496;10586.947065264625;13112.541061062817;13647.863521365056;13893.096948698303;14389.928050359682;8991.28069754405;9013.143751343612;9081.273498120267;9175.816483670156;9185.908140918506;12851.678708032374;13021.609351719464;13187.076904616968;13644.795328070286;13756.931215343859 10:30:57 INFO - 2015-12-03 10:30:57,783 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1218.2142518075837;1608.0753566699148;1661.1030043776361;1670.2483882252982;1694.3222710915632;5790.652560846347;6593;6857.794266172011;6870.690818913142;6872.862542749142;6949.235584085746;7222.061132052839;7240.479499305139;7240.855182896339;7241.855162896739;2064.4322811226884;2096.811286984171;2098.7796281390465;2099.611571859203;2101.8003289687454;2055.5580550181708;2065.39070974063;2077.781832907546;2126.064531606096;2127.0959842067136;2037.8165965063142;2053.3429302623167;2077.210659949217;2078.3349328214977;2078.657021591443;2056.9485762855898;2083.447886310129;2084.4997200671883;2085.593309304686;2086.5826834633135;2057.4856285928518;2064.9690254646193;2106.189117189893;2108.2410332280365;2108.441263065289;5962.731677074542;6081.3006504252135;7085.256048114925;7153.642317884085;7163.856722865566;4063.3904914262803;4111.8972025699295;4160.084781348099;4172.937405938914;4174.269502836992;2598.9090381836545;2643.7488438598302;2679.7722193613567;2683.5706286993986;2684.181324695967;731.2614259597791;808.458332916947;825.69449303758;893.423741686615;932.9720108396759;8950.015498295183;8957.417767845069;8958.10418958112;8974.237189838872;8989.190972812414;4015.457913181683;4089.589091763337;4114.259433302034;4145.398917156996;4186.518550366686;8198.918010819934;8215.137410571804;8236.958815205886;8299.336053115858;8305.750827475185;4285.078708077778;4293.355996600535;4294.26997410441;4295;4301.526832048472;3870.651641352292;3876.1278712290073;3882.514685664292;3906.5898080701686;3908.863189788344;3330.550375699298;3402.2515046689687;3408.705031660126;3411.812350320756;3434.364642541088;1060.0777323728405;1069.8181309177457;1079.611339917629;1082.1667316166665;1084.8210045342587;1131.3212072756444;1140.0651465797966;1162.4943149729895;1165.6036947437913;1166.4342793745027;6481.708323125471;6777.1189745332795;6976.441884649216;6991.755288564876;7017.7192912282935;1040.573364920379;1041.4584416103585;1043.9478026098664;1056.4242487844144;1064.4305296666246;4942.357493525818;5244.396894357198;5317.8404647860625;5326.36083669962;5333.200019996954;7479.401647868158;8056.798580035546;8098.595070246464;8125.715599953974;8142.592870356459;8003.119656837744;8055.436119471581;8055.879161812578;8074.313683336864;8076.515409075474;6655.367740064686;6872.553284036521;6879.759208427781;6914.861702765917;6918.169819621678;6831.351021652935;6831.89752153728;6845.931540684529;6859.657017149023;6861.55399899005;7407.296306850841;7599.924000759922;7640.8471830564185;7666.041744781903;7674;7164.9641751790905;7321.707131714672;7342.449316301192;7433.10802703679;7433.628318584158;6099.817005489843;6105.542084343603;6170.136180934763;6179.81460556184;6199.5040396767245;6782.220044694726;6821.8635627286185;6837.726490940506;6840.931590684029;6843.8973415399805;6377.5712810737905;6439.549231553746;6514.9348506514325;6515.967420163059;6575;6416.422521973045;6426.807195784134;6432.45324147434;6495.577787443801;6538.83652908662;6437.839054023687;6463.903041454476;6481.254655714653;6481.546291759531;6488.221413430419;5559.27729395176;5683.658980461186;5926.555508336805;5983.072623743326;5994.07091900756;6020.157177994996;6058.7273572688455;6071.7571297147615;6077.544184186116;6091.543134265036 10:30:57 INFO - 2015-12-03 10:30:57,785 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.6189582074496;305.7019406079073;309.20688434166345;310.379241516966;310.5543545012908;5231.764570594323;5262;5377.059014672436;5398.811041613544;5405.027095122877;5223.608229382792;5323.254744335796;5323.893522129565;5326.360836699601;5340.118880384732;3876.6511014008734;3971.7418367806144;4138;4151.771652559108;4155.898686847988;4004.159126583421;4114.958850411487;4128.133092050658;4129.277376459123;4133.677223288549;4070.043539768152;4081.4081958116053;4086.4687590613325;4086.8569600064;4092.7953602319767;3840.8847734568008;3952.6442620164034;3973.106051138471;4046.433499310099;4075.6331930126285;3530.38218311797;3538.239278555123;3549.5563054618174;3565.286942611488;3572;5115.974420127875;5116.386033675945;5119.718415487147;5123.538881500683;5124.0776660201145;4665.183592871234;4675.95324046762;4676.789544470473;4685.695429797086;4686;5386.649867758622;5551.639143455663;5558.305211848519;5576.749046292926;5578.274824272859;3862.9227415451533;3869.071422858522;3869.9226015479812;3871.0709429736944;3873.2447172801317;5772.509336706385;5811.476967072984;5851.678157701367;5861.6189947653265;5868.911966320508;3976.622220889011;3983.521977362735;3987.521497420328;3988.7806170660892;4002.7198096133575;3917.6082391761165;4037;4037.8990525237105;4040.0909795295825;4045.0494133878515;4636.721796692209;4638.373819534319;4639.582437580567;4645.581897629229;4652.604528615038;5591.552675785927;5597.440255974451;5603.495685388253;5611.579131565149;5614.719264036782;1407.7043820797542;1428.4286285485682;1429.4353730276482;1429.892758043151;1431.8210223722035;919.5769945824861;927.9628814847331;940.238406890421;945.2485274207022;959.8944116147218;4884.853454396374;4891.290762839369;4893.535114164149;4893.828715994923;4896.1921282987905;5799.971000144972;5805.10020946754;5811.77952629944;5812.041013232853;5812.7674893003805;4884.3161957326;4893.804247830119;4894.2658601210105;4897.41231052276;4900.044491324157;2869.2253091665134;2989.9402011959637;3077.353755711326;3099.4421004219007;3130.233092892256;5436.6194366393975;5510.586705996986;5511.0080185566185;5514.558835293167;5518.117101263859;6004.519638428916;6012.969935150384;6014.6391216527145;6016;6016.736485338128;5511.476409741148;5522.751476183501;5525.419830917856;5528.474794894479;5528.5024347808085;5709.115087161496;5842.065269556851;5855.502282306052;5856.0630299151935;5856.472917437451;5738.1679656450415;5746.827595172152;5747.827565173052;5760.135979603093;5765.250517432707;5511.641743286834;5523.8895222096135;5527.944720552904;5530.806421775219;5537.446255374431;3866.207427477304;3979.6617287529725;4015.0765323975065;4015.8393664253103;4024.91950161001;5727.0550359190265;5749.626274292157;5798.913016304843;5801.100829371454;5803.390643982321;5525.392206857323;5574.108142697149;5577.051901176728;5586.13414920688;5587.161925711176;5553.0559804832465;5559.972200138974;5566.332040155207;5568.053430916673;5577.414371490935;5324.281222034976;5440.156775699773;5449.073657478318;5451.536619387396;5455.809046683347;5601.075822489243;5617.359840874782;5623.2408624835125;5630.408807075362;5631.070873305859;5303.681779093266;5386.946130538645;5441.83674489766;5532.612717109924;5543.029969755196 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: |5;yui.html;665.4776000839342;684.0764967294153;727.9417646588273;750.9586972716501;760.942929280304;11612.535498580057;11763.588274410396;11815.350155741431;11827.881721182786;11849.822252666218;11608.245464044852;11856.644300670972;13127.737445251089;13243.404046817916;13274.535391261308;624.7438550194421;779.2635959018744;794.1304271822345;794.4161041634394;794.7655441644699;625.7465726380823;778.5601135358532;795.2286282306154;795.4392153531775;796.1361922314296;827.3339961331126;840.9992109389838;841.1168273313027;841.5077179849765;841.5918279634403;644.7453255963892;651.8859199640092;826.2398593294183;828.2959484438239;834.8038211020405;620.3610281410155;620.4385031546458;620.5780069552702;620.5966122020677;621.0311913415087;12377.319247441386;12491.437885295183;12516.311602861839;12522.311272879988;12524.624261272176;11150.49822757978;11594.47824847884;11618.186726929118;11826.172167948247;11905.16663833532;9323.533823308808;9350.719478415658;9409.576569054409;9426.245900327956;9455.621775128986;3185.4106990206888;3206.422843888099;3248.1717162123746;3255.8372081395837;3275.21394865233;40747;40826.591734082576;41221.79389103036;41339.173216535804;41464.792676036726;8790.42862213954;8936.687215947411;8950.373473856767;9004.144606262395;9054.637814487478;17163.141842907804;17187;17222.91388543049;17241.56896077608;17258.741118883227;6514.739410423625;6597.571157874723;6699.229588597276;6717.093192419059;6890.621015844176;3511.613722490524;3533.7879727215936;3604.513390692223;3625.148090198801;3628.600853906068;2717.6059471376934;2742.602322663203;2742.8765705543296;2747.697753247141;2752.174347695683;478.5955867292202;482.1201307613549;484.4428906757257;490.33314692018826;493.0557981465453;445.48323944224546;539.7813885376429;576.2537513919401;577.1890493856139;596.883607696495;7163.785086447415;7253;7256.346928776436;7267.63661816907;7362.7423040193335;416.03272391689444;471.1636844600861;519.550588740744;550.8182299841043;554.4372461951123;3214.533892585562;3451.3442445935193;3485.546878905726;3510.947335789965;3558.626344233818;49634.75913102129;50547.747261264194;52451.85288882679;52869.471305287225;53022.469775302525;42297.57702422998;43132;43153.136937261705;43419;43548;40676.59323406728;40958.18083638311;41522.79238603788;42101.36847947344;42128.57871421308;7947.483413578099;8169.346452283684;8315.667373305;8373.371997100363;8534.871976920227;30634.387312253184;30829.845850770602;31204.687953120178;31293.8435307822;31599.684003160593;37458.812705936296;37579.62420375871;40082.799586001885;40290.798546007085;40561.79719101386;9923.553440095357;9945.850812237677;9990.650327238513;9997.950010249902;10196.745081373025;11318.32090074598;11422.543098275975;11598.94200528992;11625.709357266136;11736.354500502213;9927.40435573868;10197.18422526211;10208.795824083329;10345.224108191765;10731.40977246259;10592.470376481298;10695.090917271807;10792.460376981277;10853.34879907208;10858.294210876267;7910.765041679472;9077.183053525214;9311.674091406769;9482.762930926781;9661.806763864824;8581.2705919995;8963.82072358536;9135.680251191176;9140.497272650067;9220.953895230748;8772.78068048304;9151.110777919224;9299.953500232456;9332.860007100035;9408.388454750419 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,907 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: __startTimestamp1449167457780__endTimestamp 10:30:57 INFO - 2015-12-03 10:30:57,786 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,787 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:30:57 INFO - 2015-12-03 10:30:57,788 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:30:57 INFO - 2015-12-03 10:30:57,788 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,788 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4604.85 Median:4722.22 stddev:478.69 (10.1%) stddev-sans-first:453.56 10:30:57 INFO - 2015-12-03 10:30:57,788 DEBUG : BROWSER_OUTPUT: Values: 2599.1 2683.1 2686.9 2698.6 2711.7 4538.0 4625.6 4659.7 4661.6 4697.8 4590.2 4594.2 4653.2 4657.3 4660.9 4278.7 4295.2 4351.5 4413.1 4443.3 4135.8 4351.3 4379.8 4423.2 4476.9 4182.2 4264.2 4290.6 4301.9 4307.0 4265.2 4312.1 4315.1 4345.2 4349.8 4065.0 4263.7 4270.6 4281.5 4321.7 4558.4 4574.3 4581.6 4591.2 4594.7 5020.4 5071.3 5073.8 5075.1 5100.9 5036.4 5048.2 5051.8 5058.0 5078.4 4441.9 4549.5 4549.9 4593.6 4665.4 5104.0 5108.4 5116.1 5120.1 5156.1 4893.1 4908.4 4915.6 4926.6 4961.6 4856.5 4914.8 4942.0 4946.8 5001.3 4958.3 4980.5 4998.3 5001.8 5021.5 4979.6 4984.6 4985.1 4986.8 5017.4 4018.6 4051.8 4089.9 4128.4 4215.8 3665.0 3681.2 3691.6 3694.9 3706.6 4339.6 4341.7 4343.6 4359.3 4373.8 4820.8 4930.6 4939.5 4985.2 4998.9 4295.7 4297.3 4300.0 4317.8 4317.8 4419.8 4444.8 4447.0 4447.6 4471.6 4584.4 4711.6 4717.2 4722.3 4817.0 5019.6 5042.6 5042.9 5045.2 5073.6 4765.7 4767.5 4768.8 4782.8 4814.5 4722.2 4821.0 4829.6 4895.9 5001.9 4988.3 4989.6 4991.1 4995.2 5051.9 4815.4 4816.5 4817.2 4832.4 4866.5 4646.9 4698.5 4778.3 4781.6 4872.0 4756.7 4776.5 4800.9 4814.2 4858.0 4876.1 4909.8 4925.4 4929.6 4965.3 4622.8 4715.5 4750.2 4757.8 4815.2 10:30:57 INFO - 2015-12-03 10:30:57,788 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,788 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42437.15 Median:3226.37 stddev:71395.81 (2212.9%) stddev-sans-first:71526.87 10:30:57 INFO - 2015-12-03 10:30:57,789 DEBUG : BROWSER_OUTPUT: Values: 563.0 568.5 568.9 571.0 573.7 27141.6 27661.7 35195.1 35665.5 35675.3 38593.8 38916.8 39110.8 39114.4 39194.2 6952.6 7930.0 8066.4 8093.0 8093.0 6841.7 6891.3 6895.9 6899.0 10344.5 10252.1 10353.5 10360.7 10362.6 10371.2 10194.1 10292.1 10297.9 10300.5 10307.8 7153.8 7285.0 10374.3 10634.3 10652.4 36503.8 36769.3 36867.8 37056.8 37128.0 2769.4 2867.5 2889.5 2922.0 2953.0 27326.0 27326.7 28049.0 29849.1 30078.0 3207.9 3218.5 3234.3 3276.8 3278.2 216689.0 217695.0 217761.9 217993.0 218446.0 54520.5 54842.5 54902.7 54909.0 54976.2 53586.0 54722.0 58001.1 59483.7 59490.4 12818.9 12949.7 12982.8 12999.1 13056.9 9851.1 9932.7 9958.1 9980.1 9981.3 18047.7 18297.8 18300.3 18910.9 19109.2 7339.8 7551.4 7629.2 7634.8 7708.7 860.8 898.3 923.0 928.7 1028.7 25560.4 25970.6 26246.9 26292.3 26343.5 947.9 971.5 974.2 1046.1 1132.1 14925.7 16043.8 16053.1 16057.0 16289.3 318283.0 323522.0 323800.0 323929.0 324187.0 46612.3 46981.8 47157.8 47243.0 47269.8 1209.2 1221.6 1237.3 1240.9 1241.2 26757.0 27565.6 27622.3 28091.2 28127.9 38434.4 38789.0 38804.6 38895.4 38961.0 238039.0 244896.0 251328.0 296034.0 301251.0 26809.9 26813.2 26816.3 26837.5 27188.6 34020.1 34184.8 34754.5 35035.6 35127.5 31762.8 31899.4 31954.8 32779.8 32904.3 31939.2 32423.0 32619.7 32666.8 32728.8 32523.7 32621.3 32684.3 32857.8 34892.3 26422.5 29194.9 30395.4 30640.1 30694.7 23835.0 23891.7 23902.2 24248.5 24445.4 10:30:57 INFO - 2015-12-03 10:30:57,789 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,789 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23075.78 Median:310185.00 stddev:57054.98 (18.4%) stddev-sans-first:57189.46 10:30:57 INFO - 2015-12-03 10:30:57,789 DEBUG : BROWSER_OUTPUT: Values: 323.2 329.7 330.7 333.8 335.1 12245.3 12594.2 14527.6 14956.6 16109.7 14149.8 14710.0 14886.6 15400.2 15447.9 4999.8 5195.0 6052.3 6232.1 6245.9 3902.4 4014.6 6328.5 6439.2 6689.9 6460.5 6574.7 6590.5 6646.0 6646.5 6561.9 6584.4 6600.9 6610.9 6614.4 6149.9 6307.0 6309.4 6317.6 6325.7 18944.3 19045.1 19654.0 20338.5 20782.4 1959.4 1986.8 2043.6 2087.7 2120.2 12840.1 12925.7 13055.4 13355.5 13487.3 1803.2 1895.4 1896.7 1916.6 1936.5 57704.4 61505.7 61569.8 61783.4 62484.7 15174.5 15177.4 15195.2 15201.8 15350.0 22345.9 22571.5 22604.2 22646.4 22691.9 7954.7 7979.9 7994.6 8060.2 8100.8 6790.6 6828.6 6856.1 6897.2 6907.6 6483.7 7495.8 7527.5 7529.8 7544.8 1659.8 2072.5 2423.5 2909.9 2959.8 507.8 842.5 905.3 948.9 950.2 12877.8 14866.6 14912.8 15525.5 15797.8 827.4 842.2 848.8 870.0 877.7 8224.6 8871.0 8981.8 9034.3 9250.9 307986.0 312384.0 313827.0 314645.0 461932.0 60906.7 73382.6 73395.3 73809.3 73995.6 1002.8 1026.6 1027.5 1034.3 1046.6 13695.5 14009.5 14043.9 14440.9 14581.9 29289.6 30027.7 30049.7 30151.5 30418.1 39907.0 40122.8 40680.4 40705.8 41147.6 8850.3 9287.0 9349.2 9378.9 9388.9 14962.0 15157.8 16239.6 16246.4 16750.2 10247.8 12983.2 13222.7 13260.2 13443.9 12864.0 12874.7 12958.2 12987.0 13072.7 10586.9 13112.5 13647.9 13893.1 14389.9 8991.3 9013.1 9081.3 9175.8 9185.9 12851.7 13021.6 13187.1 13644.8 13756.9 10:30:57 INFO - 2015-12-03 10:30:57,790 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,790 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4925.10 Median:6079.42 stddev:2475.77 (40.7%) stddev-sans-first:2467.03 10:30:57 INFO - 2015-12-03 10:30:57,790 DEBUG : BROWSER_OUTPUT: Values: 1218.2 1608.1 1661.1 1670.2 1694.3 5790.7 6593.0 6857.8 6870.7 6872.9 6949.2 7222.1 7240.5 7240.9 7241.9 2064.4 2096.8 2098.8 2099.6 2101.8 2055.6 2065.4 2077.8 2126.1 2127.1 2037.8 2053.3 2077.2 2078.3 2078.7 2056.9 2083.4 2084.5 2085.6 2086.6 2057.5 2065.0 2106.2 2108.2 2108.4 5962.7 6081.3 7085.3 7153.6 7163.9 4063.4 4111.9 4160.1 4172.9 4174.3 2598.9 2643.7 2679.8 2683.6 2684.2 731.3 808.5 825.7 893.4 933.0 8950.0 8957.4 8958.1 8974.2 8989.2 4015.5 4089.6 4114.3 4145.4 4186.5 8198.9 8215.1 8237.0 8299.3 8305.8 4285.1 4293.4 4294.3 4295.0 4301.5 3870.7 3876.1 3882.5 3906.6 3908.9 3330.6 3402.3 3408.7 3411.8 3434.4 1060.1 1069.8 1079.6 1082.2 1084.8 1131.3 1140.1 1162.5 1165.6 1166.4 6481.7 6777.1 6976.4 6991.8 7017.7 1040.6 1041.5 1043.9 1056.4 1064.4 4942.4 5244.4 5317.8 5326.4 5333.2 7479.4 8056.8 8098.6 8125.7 8142.6 8003.1 8055.4 8055.9 8074.3 8076.5 6655.4 6872.6 6879.8 6914.9 6918.2 6831.4 6831.9 6845.9 6859.7 6861.6 7407.3 7599.9 7640.8 7666.0 7674.0 7165.0 7321.7 7342.4 7433.1 7433.6 6099.8 6105.5 6170.1 6179.8 6199.5 6782.2 6821.9 6837.7 6840.9 6843.9 6377.6 6439.5 6514.9 6516.0 6575.0 6416.4 6426.8 6432.5 6495.6 6538.8 6437.8 6463.9 6481.3 6481.5 6488.2 5559.3 5683.7 5926.6 5983.1 5994.1 6020.2 6058.7 6071.8 6077.5 6091.5 10:30:57 INFO - 2015-12-03 10:30:57,790 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,790 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4625.26 Median:5324.09 stddev:1375.18 (25.8%) stddev-sans-first:1340.24 10:30:57 INFO - 2015-12-03 10:30:57,791 DEBUG : BROWSER_OUTPUT: Values: 303.6 305.7 309.2 310.4 310.6 5231.8 5262.0 5377.1 5398.8 5405.0 5223.6 5323.3 5323.9 5326.4 5340.1 3876.7 3971.7 4138.0 4151.8 4155.9 4004.2 4115.0 4128.1 4129.3 4133.7 4070.0 4081.4 4086.5 4086.9 4092.8 3840.9 3952.6 3973.1 4046.4 4075.6 3530.4 3538.2 3549.6 3565.3 3572.0 5116.0 5116.4 5119.7 5123.5 5124.1 4665.2 4676.0 4676.8 4685.7 4686.0 5386.6 5551.6 5558.3 5576.7 5578.3 3862.9 3869.1 3869.9 3871.1 3873.2 5772.5 5811.5 5851.7 5861.6 5868.9 3976.6 3983.5 3987.5 3988.8 4002.7 3917.6 4037.0 4037.9 4040.1 4045.0 4636.7 4638.4 4639.6 4645.6 4652.6 5591.6 5597.4 5603.5 5611.6 5614.7 1407.7 1428.4 1429.4 1429.9 1431.8 919.6 928.0 940.2 945.2 959.9 4884.9 4891.3 4893.5 4893.8 4896.2 5800.0 5805.1 5811.8 5812.0 5812.8 4884.3 4893.8 4894.3 4897.4 4900.0 2869.2 2989.9 3077.4 3099.4 3130.2 5436.6 5510.6 5511.0 5514.6 5518.1 6004.5 6013.0 6014.6 6016.0 6016.7 5511.5 5522.8 5525.4 5528.5 5528.5 5709.1 5842.1 5855.5 5856.1 5856.5 5738.2 5746.8 5747.8 5760.1 5765.3 5511.6 5523.9 5527.9 5530.8 5537.4 3866.2 3979.7 4015.1 4015.8 4024.9 5727.1 5749.6 5798.9 5801.1 5803.4 5525.4 5574.1 5577.1 5586.1 5587.2 5553.1 5560.0 5566.3 5568.1 5577.4 5324.3 5440.2 5449.1 5451.5 5455.8 5601.1 5617.4 5623.2 5630.4 5631.1 5303.7 5386.9 5441.8 5532.6 5543.0 10:30:57 INFO - 2015-12-03 10:30:57,791 DEBUG : BROWSER_OUTPUT: 10:30:57 INFO - 2015-12-03 10:30:57,791 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12301.55 Median:487.39 stddev:13957.72 (2863.8%) stddev-sans-first:13969.52 10:30:57 INFO - 2015-12-03 10:30:57,791 DEBUG : BROWSER_OUTPUT: Values: 665.5 684.1 727.9 751.0 760.9 11612.5 11763.6 11815.4 11827.9 11849.8 11608.2 11856.6 13127.7 13243.4 13274.5 624.7 779.3 794.1 794.4 794.8 625.7 778.6 795.2 795.4 796.1 827.3 841.0 841.1 841.5 841.6 644.7 651.9 826.2 828.3 834.8 620.4 620.4 620.6 620.6 621.0 12377.3 12491.4 12516.3 12522.3 12524.6 11150.5 11594.5 11618.2 11826.2 11905.2 9323.5 9350.7 9409.6 9426.2 9455.6 3185.4 3206.4 3248.2 3255.8 3275.2 40747.0 40826.6 41221.8 41339.2 41464.8 8790.4 8936.7 8950.4 9004.1 9054.6 17163.1 17187.0 17222.9 17241.6 17258.7 6514.7 6597.6 6699.2 6717.1 6890.6 3511.6 3533.8 3604.5 3625.1 3628.6 2717.6 2742.6 2742.9 2747.7 2752.2 478.6 482.1 484.4 490.3 493.1 445.5 539.8 576.3 577.2 596.9 7163.8 7253.0 7256.3 7267.6 7362.7 416.0 471.2 519.6 550.8 554.4 3214.5 3451.3 3485.5 3510.9 3558.6 49634.8 50547.7 52451.9 52869.5 53022.5 42297.6 43132.0 43153.1 43419.0 43548.0 40676.6 40958.2 41522.8 42101.4 42128.6 7947.5 8169.3 8315.7 8373.4 8534.9 30634.4 30829.8 31204.7 31293.8 31599.7 37458.8 37579.6 40082.8 40290.8 40561.8 9923.6 9945.9 9990.7 9998.0 10196.7 11318.3 11422.5 11598.9 11625.7 11736.4 9927.4 10197.2 10208.8 10345.2 10731.4 10592.5 10695.1 10792.5 10853.3 10858.3 7910.8 9077.2 9311.7 9482.8 9661.8 8581.3 8963.8 9135.7 9140.5 9221.0 8772.8 9151.1 9300.0 9332.9 9408.4 10:30:57 INFO - 2015-12-03 10:30:57,791 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:30:57 INFO - 2015-12-03 10:30:57,791 DEBUG : BROWSER_OUTPUT: 10:30:58 INFO - 2015-12-03 10:30:58,543 INFO : Browser exited with error code: 0 10:30:58 INFO - 2015-12-03 10:30:58,561 INFO : Completed test dromaeo_css (00:18:36) 10:30:58 INFO - 2015-12-03 10:30:58,561 INFO : Starting test kraken 10:30:58 INFO - 2015-12-03 10:30:58,561 DEBUG : operating with platform_type : linux_ 10:30:58 INFO - 2015-12-03 10:30:58,562 INFO : Initialising browser for kraken test... 10:30:58 INFO - 2015-12-03 10:30:58,568 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5xhXY/profile http://localhost:42867/getInfo.html 10:31:02 INFO - 2015-12-03 10:31:02,544 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:31:02 INFO - 2015-12-03 10:31:02,544 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:31:02 INFO - 2015-12-03 10:31:02,544 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:31:02 INFO - 2015-12-03 10:31:02,544 DEBUG : BROWSER_OUTPUT: __metrics 10:31:02 INFO - 2015-12-03 10:31:02,628 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:31:02 INFO - 2015-12-03 10:31:02,629 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:31:03 INFO - 2015-12-03 10:31:03,837 INFO : Browser initialized. 10:31:03 INFO - 2015-12-03 10:31:03,838 INFO : Running cycle 1/1 for kraken test... 10:31:03 INFO - 2015-12-03 10:31:03,838 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV5xhXY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:31:15 INFO - 2015-12-03 10:31:15,894 DEBUG : BROWSER_OUTPUT: RSS: Main: 143093760 10:31:15 INFO - 2015-12-03 10:31:15,894 DEBUG : BROWSER_OUTPUT: 10:31:18 INFO - 2015-12-03 10:31:18,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42867/tests/kraken/driver.html?testName=audio-beat-detection) 10:31:19 INFO - 2015-12-03 10:31:19,092 DEBUG : BROWSER_OUTPUT: RSS: Main: 183451648 10:31:19 INFO - 2015-12-03 10:31:19,092 DEBUG : BROWSER_OUTPUT: 10:31:21 INFO - 2015-12-03 10:31:21,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42867/tests/kraken/driver.html?testName=audio-dft) 10:31:22 INFO - 2015-12-03 10:31:22,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 172195840 10:31:22 INFO - 2015-12-03 10:31:22,399 DEBUG : BROWSER_OUTPUT: 10:31:25 INFO - 2015-12-03 10:31:25,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42867/tests/kraken/driver.html?testName=audio-fft) 10:31:26 INFO - 2015-12-03 10:31:26,005 DEBUG : BROWSER_OUTPUT: RSS: Main: 155230208 10:31:26 INFO - 2015-12-03 10:31:26,005 DEBUG : BROWSER_OUTPUT: 10:31:28 INFO - 2015-12-03 10:31:28,057 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42867/tests/kraken/driver.html?testName=audio-oscillator) 10:31:28 INFO - 2015-12-03 10:31:28,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 156659712 10:31:28 INFO - 2015-12-03 10:31:28,626 DEBUG : BROWSER_OUTPUT: 10:31:30 INFO - 2015-12-03 10:31:30,881 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:31:31 INFO - 2015-12-03 10:31:31,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 157642752 10:31:31 INFO - 2015-12-03 10:31:31,447 DEBUG : BROWSER_OUTPUT: 10:31:34 INFO - 2015-12-03 10:31:34,431 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42867/tests/kraken/driver.html?testName=imaging-darkroom) 10:31:35 INFO - 2015-12-03 10:31:35,012 DEBUG : BROWSER_OUTPUT: RSS: Main: 158216192 10:31:35 INFO - 2015-12-03 10:31:35,013 DEBUG : BROWSER_OUTPUT: 10:31:38 INFO - 2015-12-03 10:31:38,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42867/tests/kraken/driver.html?testName=imaging-desaturate) 10:31:38 INFO - 2015-12-03 10:31:38,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 159358976 10:31:38 INFO - 2015-12-03 10:31:38,961 DEBUG : BROWSER_OUTPUT: 10:31:41 INFO - 2015-12-03 10:31:41,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42867/tests/kraken/driver.html?testName=json-parse-financial) 10:31:42 INFO - 2015-12-03 10:31:42,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 156807168 10:31:42 INFO - 2015-12-03 10:31:42,373 DEBUG : BROWSER_OUTPUT: 10:31:44 INFO - 2015-12-03 10:31:44,145 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:31:44 INFO - 2015-12-03 10:31:44,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 168108032 10:31:44 INFO - 2015-12-03 10:31:44,718 DEBUG : BROWSER_OUTPUT: 10:31:46 INFO - 2015-12-03 10:31:46,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:31:47 INFO - 2015-12-03 10:31:47,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 166756352 10:31:47 INFO - 2015-12-03 10:31:47,218 DEBUG : BROWSER_OUTPUT: 10:31:49 INFO - 2015-12-03 10:31:49,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:31:49 INFO - 2015-12-03 10:31:49,932 DEBUG : BROWSER_OUTPUT: RSS: Main: 181170176 10:31:49 INFO - 2015-12-03 10:31:49,932 DEBUG : BROWSER_OUTPUT: 10:31:52 INFO - 2015-12-03 10:31:52,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:31:53 INFO - 2015-12-03 10:31:53,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 185356288 10:31:53 INFO - 2015-12-03 10:31:53,039 DEBUG : BROWSER_OUTPUT: 10:31:55 INFO - 2015-12-03 10:31:55,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:31:56 INFO - 2015-12-03 10:31:56,252 DEBUG : BROWSER_OUTPUT: RSS: Main: 185540608 10:31:56 INFO - 2015-12-03 10:31:56,252 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42867/tests/kraken/driver.html?testName=ai-astar) 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 241201152 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:31:58 INFO - 2015-12-03 10:31:58,272 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;106;112;113;113;102;114;119;104 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;156;169;129;149;160;133;179;129 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;161;159;159;162;163;162;165 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;92;73;71;72;110;92;72 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;134;94;95;95;128;95;94;137 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;110;109;109;110 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;148;146;147;146;148;146;147;147 10:31:58 INFO - 2015-12-03 10:31:58,273 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;96;95;96;96;95;96 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;71;72;72;71;78;71;79;70;70 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;68;69;69;69;69;70;69;68;69 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;84;86;85;84;85;86;85;84 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;132;126;118;125;121;116;130;119;127 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;145;148;136;149;134;147;146;137;138 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;70;69;70;68;67;68;68 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:31:58 INFO - 2015-12-03 10:31:58,274 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:31:58 INFO - 2015-12-03 10:31:58,275 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 10:31:58 INFO - 2015-12-03 10:31:58,275 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:31:58 INFO - 2015-12-03 10:31:58,275 DEBUG : BROWSER_OUTPUT: __startTimestamp1449167518266__endTimestamp 10:31:58 INFO - 2015-12-03 10:31:58,275 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,275 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:31:58 INFO - 2015-12-03 10:31:58,277 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:31:58 INFO - 2015-12-03 10:31:58,277 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,277 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:113.00 stddev:5.22 (4.6%) stddev-sans-first:5.54 10:31:58 INFO - 2015-12-03 10:31:58,277 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 106.0 112.0 113.0 113.0 102.0 114.0 119.0 104.0 10:31:58 INFO - 2015-12-03 10:31:58,277 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:156.00 stddev:18.18 (11.7%) stddev-sans-first:19.10 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 156.0 169.0 129.0 149.0 160.0 133.0 179.0 129.0 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 161.0 159.0 159.0 162.0 163.0 162.0 165.0 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,278 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:73.00 stddev:13.18 (18.1%) stddev-sans-first:13.56 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 92.0 73.0 71.0 72.0 110.0 92.0 72.0 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:18.76 (20.0%) stddev-sans-first:19.39 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 134.0 94.0 95.0 95.0 128.0 95.0 94.0 137.0 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 148.0 146.0 147.0 146.0 148.0 146.0 147.0 147.0 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:31:58 INFO - 2015-12-03 10:31:58,279 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 96.0 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.50 Median:71.50 stddev:3.24 (4.5%) stddev-sans-first:3.39 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 72.0 71.0 78.0 71.0 79.0 70.0 70.0 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: Values: 70.0 68.0 69.0 69.0 69.0 69.0 70.0 69.0 68.0 69.0 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,280 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:0.82 (1.0%) stddev-sans-first:0.87 10:31:58 INFO - 2015-12-03 10:31:58,281 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 84.0 86.0 85.0 84.0 85.0 86.0 85.0 84.0 10:31:58 INFO - 2015-12-03 10:31:58,281 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,281 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.40 Median:125.50 stddev:5.38 (4.3%) stddev-sans-first:5.56 10:31:58 INFO - 2015-12-03 10:31:58,281 DEBUG : BROWSER_OUTPUT: Values: 120.0 132.0 126.0 118.0 125.0 121.0 116.0 130.0 119.0 127.0 10:31:58 INFO - 2015-12-03 10:31:58,281 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.30 Median:146.50 stddev:8.59 (5.9%) stddev-sans-first:5.87 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: Values: 163.0 145.0 148.0 136.0 149.0 134.0 147.0 146.0 137.0 138.0 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.12 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 70.0 69.0 70.0 68.0 67.0 68.0 68.0 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:31:58 INFO - 2015-12-03 10:31:58,282 DEBUG : BROWSER_OUTPUT: 10:31:59 INFO - 2015-12-03 10:31:59,147 INFO : Browser exited with error code: 0 10:31:59 INFO - 2015-12-03 10:31:59,196 INFO : Completed test kraken (00:01:00) 10:31:59 INFO - 2015-12-03 10:31:59,197 INFO : Starting test v8_7 10:31:59 INFO - 2015-12-03 10:31:59,197 DEBUG : operating with platform_type : linux_ 10:31:59 INFO - 2015-12-03 10:31:59,197 INFO : Initialising browser for v8_7 test... 10:31:59 INFO - 2015-12-03 10:31:59,203 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6GvVYw/profile http://localhost:42867/getInfo.html 10:32:03 INFO - 2015-12-03 10:32:03,077 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:32:03 INFO - 2015-12-03 10:32:03,077 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:32:03 INFO - 2015-12-03 10:32:03,077 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:32:03 INFO - 2015-12-03 10:32:03,077 DEBUG : BROWSER_OUTPUT: __metrics 10:32:03 INFO - 2015-12-03 10:32:03,214 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:32:03 INFO - 2015-12-03 10:32:03,214 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:32:04 INFO - 2015-12-03 10:32:04,239 INFO : Browser initialized. 10:32:04 INFO - 2015-12-03 10:32:04,240 INFO : Running cycle 1/1 for v8_7 test... 10:32:04 INFO - 2015-12-03 10:32:04,240 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6GvVYw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:32:16 INFO - 2015-12-03 10:32:16,182 DEBUG : BROWSER_OUTPUT: RSS: Main: 142921728 10:32:16 INFO - 2015-12-03 10:32:16,182 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,648 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:42867/tests/v8_7/run.html (next: http://localhost:42867/tests/v8_7/run.html) 10:32:37 INFO - 2015-12-03 10:32:37,898 DEBUG : BROWSER_OUTPUT: RSS: Main: 494661632 10:32:37 INFO - 2015-12-03 10:32:37,898 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,899 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:32:37 INFO - 2015-12-03 10:32:37,899 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:32:37 INFO - 2015-12-03 10:32:37,899 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |0;Richards;165.53550736633008 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.84288354898337 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.77777777777777 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2109.7046413502107 10:32:37 INFO - 2015-12-03 10:32:37,900 DEBUG : BROWSER_OUTPUT: |5;Earley;795.5449482895783 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: |8;Splay;626.5664160401003 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4864.077669902913 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: __startTimestamp1449167557898__endTimestamp 10:32:37 INFO - 2015-12-03 10:32:37,901 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: Values: 165.5 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.84 Median:184.84 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: Values: 184.8 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: Values: 277.8 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: Values: 5133.3 10:32:37 INFO - 2015-12-03 10:32:37,903 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2109.70 Median:2109.70 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: Values: 2109.7 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:795.54 Median:795.54 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: Values: 795.5 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: Values: 12243.9 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: Values: 27054.1 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:626.57 Median:626.57 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: Values: 626.6 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: 10:32:37 INFO - 2015-12-03 10:32:37,904 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4864.08 Median:4864.08 stddev:0.00 (0.0%) 10:32:37 INFO - 2015-12-03 10:32:37,905 DEBUG : BROWSER_OUTPUT: Values: 4864.1 10:32:37 INFO - 2015-12-03 10:32:37,905 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:32:37 INFO - 2015-12-03 10:32:37,905 DEBUG : BROWSER_OUTPUT: 10:32:38 INFO - 2015-12-03 10:32:38,763 INFO : Browser exited with error code: 0 10:32:38 INFO - 2015-12-03 10:32:38,780 INFO : Completed test v8_7 (00:00:39) 10:32:38 INFO - 2015-12-03 10:32:38,881 INFO : Completed test suite (00:20:17) 10:32:38 INFO - 2015-12-03 10:32:38,881 DEBUG : Working with test: dromaeo_css 10:32:38 INFO - 2015-12-03 10:32:38,881 DEBUG : Generating results file: dromaeo_css 10:32:38 INFO - 2015-12-03 10:32:38,883 DEBUG : Working with test: kraken 10:32:38 INFO - 2015-12-03 10:32:38,883 DEBUG : Generating results file: kraken 10:32:38 INFO - 2015-12-03 10:32:38,883 INFO : javascript benchmark 10:32:38 INFO - 2015-12-03 10:32:38,883 DEBUG : Working with test: v8_7 10:32:38 INFO - 2015-12-03 10:32:38,883 DEBUG : Generating results file: v8_7 10:32:38 INFO - 2015-12-03 10:32:38,884 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:32:38 INFO - 2015-12-03 10:32:38,936 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 10:32:38 INFO - 2015-12-03 10:32:38,937 DEBUG : process_Request line: dromaeo_css 6385.10 graph.html#tests=[[72,203,35]] 10:32:38 INFO - 2015-12-03 10:32:38,937 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:32:38 INFO - 2015-12-03 10:32:38,975 DEBUG : process_Request line: kraken 1523.00 graph.html#tests=[[232,203,35]] 10:32:38 INFO - 2015-12-03 10:32:38,975 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:32:39 INFO - 2015-12-03 10:32:39,004 DEBUG : process_Request line: v8_7 19613.42 graph.html#tests=[[230,203,35]] 10:32:39 INFO - 2015-12-03 10:32:39,006 INFO : javascript benchmark 10:32:39 INFO - 2015-12-03 10:32:39,009 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2599.07732754872, 2683.141394753677, 2686.9462610747773, 2698.5817198334266, 2711.7288271172883, 4538.047010127877, 4625.629949604032, 4659.650526210535, 4661.5804577588015, 4697.8120875165, 4590.219662657348, 4594.150082234789, 4653.208954477738, 4657.278121891104, 4660.906781864361, 4278.679099067567, 4295.205387003399, 4351.477822661285, 4413.0732546165345, 4443.333499974998, 4135.77253251071, 4351.347297905308, 4379.846705365313, 4423.181711383404, 4476.910461790762, 4182.226288136704, 4264.189803937257, 4290.613844753956, 4301.892452688677, 4307.0, 4265.168292183025, 4312.137572485484, 4315.05068884848, 4345.196138714348, 4349.826006959749, 4064.959350406488, 4263.72285801425, 4270.6156445919705, 4281.4521872961095, 4321.697481176319, 4558.361829343895, 4574.268117101281, 4581.5647513486165, 4591.219492686251, 4594.65540084495, 5020.3724534433195, 5071.3407257056715, 5073.771680274396, 5075.061113693979, 5100.897982040338, 5036.370453693288, 5048.178566631653, 5051.772670229849, 5057.974710126426, 5078.365204349457, 4441.888952776174, 4549.45406551216, 4549.863504094882, 4593.6095431888, 4665.370175026362, 5104.03023425548, 5108.438071812097, 5116.130257856174, 5120.078385890501, 5156.097682905476, 4893.09477746618, 4908.361912951294, 4915.631327650369, 4926.605871530269, 4961.578265847371, 4856.514348565115, 4914.827981020647, 4942.0, 4946.826861059845, 5001.274815151783, 4958.330625365529, 4980.501949805063, 4998.300237966688, 5001.774920128603, 5021.548060674557, 4979.551840334388, 4984.576311013604, 4985.052839960396, 4986.750662466862, 5017.397912250553, 4018.557958624549, 4051.756894586334, 4089.89775255621, 4128.380742888591, 4215.768132752667, 3664.9633503664622, 3681.1533347330264, 3691.6492933171307, 3694.8891533254045, 3706.6293370663257, 4339.609435150852, 4341.674374421931, 4343.609075183249, 4359.280718681445, 4373.825046998148, 4820.831270905502, 4930.605551555938, 4939.456659767423, 4985.152524070917, 4998.850034498971, 4295.677824163137, 4297.269464191095, 4300.03249268912, 4317.805698743564, 4317.805698743564, 4419.756913369732, 4444.844430444984, 4446.955530444654, 4447.644188464915, 4471.619912307425, 4584.358189853423, 4711.575958163645, 4717.245240761462, 4722.268048452495, 4817.0365926814775, 5019.623528235324, 5042.621803364689, 5042.899142017212, 5045.192769156917, 5073.619478539198, 4765.690230135169, 4767.523247675204, 4768.785404656868, 4782.832600858953, 4814.542618451242, 4722.220833562561, 4821.011692603078, 4829.5653391194965, 4895.926561101657, 5001.924971125363, 4988.276699878425, 4989.625778066732, 4991.101601711727, 4995.225740010304, 5051.924221136759, 4815.374001379798, 4816.54242846929, 4817.156997525489, 4832.420109586872, 4866.537678920497, 4646.86059418218, 4698.459677137173, 4778.331033655221, 4781.5935645469135, 4871.975640121776, 4756.6908150970075, 4776.450708168605, 4800.879978000578, 4814.15752243349, 4857.975710121426, 4876.073546026244, 4909.803607855646, 4925.433575138905, 4929.580985616263, 4965.255211718271, 4622.815087396467, 4715.528447155257, 4750.216214324598, 4757.785899634594, 4815.235675616622], "unit": "ms", "name": "dojo.html", "value": 4575.191024200932}, {"lowerIsBetter": false, "replicates": [562.9577781666374, 568.5309619563861, 568.9402612725663, 570.9864989643384, 573.7045421607872, 27141.592876106875, 27661.723382766166, 35195.120121996966, 35665.46501802468, 35675.2864942701, 38593.8070309648, 38916.80541597288, 39110.8044459778, 39114.413283800764, 39194.21611567767, 6952.617606031667, 7929.960350198241, 8066.4353495255355, 8092.959535202316, 8092.959535202316, 6841.657917104125, 6891.276415976326, 6895.896561551581, 6898.965505172467, 10344.482775861214, 10252.128569071638, 10353.482325883713, 10360.740981475448, 10362.637307694233, 10371.222158338154, 10194.133498652587, 10292.073713365833, 10297.948510257476, 10300.536475858604, 10307.845382319309, 7153.785386438363, 7285.0165227694115, 10374.273800833944, 10634.255602107856, 10652.41411722355, 36503.817480912694, 36769.26461470756, 36867.81566092179, 37056.814715926244, 37128.0, 2769.404578015736, 2867.4981878171443, 2889.4516111379107, 2921.985390073036, 2953.040261914865, 27326.0, 27326.726732732815, 28049.0, 29849.10452686423, 30078.003120124675, 3207.85564649589, 3218.4593962902277, 3234.272288735039, 3276.836158192081, 3278.1804548862783, 216689.0, 217695.0, 217761.91119044463, 217993.0, 218446.0, 54520.45479545154, 54842.451575483734, 54902.725486372314, 54909.0, 54976.17535736967, 53586.0, 54722.0, 58001.12998305029, 59483.70258148682, 59490.405095949354, 12818.871811281768, 12949.741005179843, 12982.805257921138, 12999.09006369564, 13056.934715326362, 9851.064148905842, 9932.702018939442, 9958.053984871425, 9980.051895069957, 9981.251406144569, 18047.729284060748, 18297.817021829876, 18300.267989280546, 18910.905445472683, 19109.235630574898, 7339.77980660581, 7551.433642476836, 7629.160792312841, 7634.8091297718, 7708.653110610036, 860.8149247911729, 898.2679116520015, 922.9907700922905, 928.7445952363154, 1028.6605420211313, 25560.360990975, 25970.610440843404, 26246.86876565605, 26292.342691432485, 26343.47313053728, 947.9289053321029, 971.4705485510414, 974.2011550528499, 1046.1108058150662, 1132.1452303510962, 14925.70148597022, 16043.759343609856, 16053.117078560557, 16057.0, 16289.266982985793, 318283.0, 323522.0, 323800.0, 323929.0, 324187.0, 46612.3008154878, 46981.765091174326, 47157.76421117873, 47243.0, 47269.76365118221, 1209.1656756837754, 1221.6029790318182, 1237.3256575166556, 1240.8573014103313, 1241.1622155045309, 26757.0, 27565.586516202675, 27622.309442264104, 28091.157265282076, 28127.859360703886, 38434.42348364833, 38789.0, 38804.6119538801, 38895.41656875092, 38961.0, 238039.0, 244896.0, 251328.0, 296034.0, 301251.0, 26809.865950670122, 26813.195604131906, 26816.329591759582, 26837.463250735265, 27188.592171117052, 34020.1494962618, 34184.82907585446, 34754.478682820285, 35035.64964350324, 35127.47308790319, 31762.841185793925, 31899.36201276008, 31954.84022579872, 32779.836100819346, 32904.34191316112, 31939.201519961258, 32423.0, 32619.673803261663, 32666.836665816518, 32728.836355818068, 32523.67476325301, 32621.347573047933, 32684.34631307313, 32857.835710821295, 34892.30215395729, 26422.53409215095, 29194.854025729735, 30395.392092157592, 30640.097584386393, 30694.693053070077, 23835.0, 23891.67093504961, 23902.16342428007, 24248.515029698956, 24445.38886527851], "unit": "ms", "name": "ext.html", "value": 17092.741672677774}, {"lowerIsBetter": false, "replicates": [323.20169182120156, 329.7218588810188, 330.7337593237444, 333.79471624950656, 335.1019268360792, 12245.32650704211, 12594.244345339263, 14527.636809079779, 14956.5513034609, 16109.677806443864, 14149.787753183711, 14710.0, 14886.553403397915, 15400.229988500587, 15447.918645694806, 4999.800007999685, 5195.0, 6052.334243233241, 6232.096346029823, 6245.875082498347, 3902.356111241642, 4014.6386825185728, 6328.462080723144, 6439.227292724856, 6689.8662026759675, 6460.515461340418, 6574.737010519598, 6590.538662293641, 6646.0, 6646.501512386566, 6561.868762624745, 6584.440322572587, 6600.867982640344, 6610.900836487408, 6614.437772789294, 6149.907751383733, 6306.968465157691, 6309.400606942333, 6317.6209427434505, 6325.715342809539, 18944.336948206885, 19045.142968566448, 19654.0, 20338.49153771153, 20782.376528704164, 1959.4415591556337, 1986.8112529309692, 2043.5606344635974, 2087.749470063602, 2120.2261174671135, 12840.1011929165, 12925.741485170338, 13055.412506437233, 13355.532556360578, 13487.258200798951, 1803.1525183164024, 1895.4029480713532, 1896.6680830854546, 1916.6358391905494, 1936.5061909213061, 57704.42295577032, 61505.692471537805, 61569.7686046281, 61783.38216617821, 62484.687576561824, 15174.544763657108, 15177.392904283704, 15195.164265965477, 15201.771973420407, 15350.0, 22345.88827055887, 22571.548569028528, 22604.208852690077, 22646.433839154153, 22691.886540567193, 7954.721584744506, 7979.880301795478, 7994.6002699864775, 8060.15368386311, 8100.797480062928, 6790.59256444605, 6828.5902845829405, 6856.074429951992, 6897.172339319314, 6907.620080895498, 6483.7082331295205, 7495.812604684927, 7527.510711803715, 7529.8117547061765, 7544.8491030180185, 1659.8423149800992, 2072.492239401326, 2423.503181847717, 2909.898153564615, 2959.8224106553675, 507.79434329096773, 842.5071333270106, 905.2531661379256, 948.9240860731124, 950.2350607760819, 12877.806832897513, 14866.554003379915, 14912.776308355384, 15525.534233973, 15797.842021579867, 827.3587969323702, 842.1704620948483, 848.809017970964, 869.9521526315987, 877.6664867350366, 8224.62989165489, 8871.0, 8981.775455613662, 9034.277257819358, 9250.86123708145, 307986.0, 312384.0, 313827.0, 314645.0, 461932.0, 60906.69546652238, 73382.6330868353, 73395.26604733992, 73809.26190738023, 73995.63002184955, 1002.8044531316323, 1026.5688410867454, 1027.4708525109575, 1034.2863424237253, 1046.6389095762102, 13695.452181912611, 14009.509667161601, 14043.929780351033, 14440.855591443951, 14581.85418145805, 29289.560656589743, 30027.69972300249, 30049.69950300469, 30151.547726784556, 30418.087457376314, 39907.0, 40122.79938600288, 40680.38979415252, 40705.79647101746, 41147.55983540562, 8850.336224783296, 9287.0, 9349.205317548085, 9378.859317110113, 9388.906110939077, 14962.0, 15157.848421516084, 16239.59401014984, 16246.431374901822, 16750.162491875602, 10247.846282305622, 12983.221006739626, 13222.735545288848, 13260.204387736767, 13443.932780336036, 12864.0, 12874.67813304675, 12958.22250664963, 12987.0, 13072.673183170496, 10586.947065264625, 13112.541061062817, 13647.863521365056, 13893.096948698303, 14389.928050359682, 8991.28069754405, 9013.143751343612, 9081.273498120267, 9175.816483670156, 9185.908140918506, 12851.678708032374, 13021.609351719464, 13187.076904616968, 13644.795328070286, 13756.931215343859], "unit": "ms", "name": "jquery.html", "value": 8951.182169011421}, {"lowerIsBetter": false, "replicates": [1218.2142518075837, 1608.0753566699148, 1661.1030043776361, 1670.2483882252982, 1694.3222710915632, 5790.652560846347, 6593.0, 6857.794266172011, 6870.690818913142, 6872.862542749142, 6949.235584085746, 7222.061132052839, 7240.479499305139, 7240.855182896339, 7241.855162896739, 2064.4322811226884, 2096.811286984171, 2098.7796281390465, 2099.611571859203, 2101.8003289687454, 2055.5580550181708, 2065.39070974063, 2077.781832907546, 2126.064531606096, 2127.0959842067136, 2037.8165965063142, 2053.3429302623167, 2077.210659949217, 2078.3349328214977, 2078.657021591443, 2056.9485762855898, 2083.447886310129, 2084.4997200671883, 2085.593309304686, 2086.5826834633135, 2057.4856285928518, 2064.9690254646193, 2106.189117189893, 2108.2410332280365, 2108.441263065289, 5962.731677074542, 6081.3006504252135, 7085.256048114925, 7153.642317884085, 7163.856722865566, 4063.3904914262803, 4111.8972025699295, 4160.084781348099, 4172.937405938914, 4174.269502836992, 2598.9090381836545, 2643.7488438598302, 2679.7722193613567, 2683.5706286993986, 2684.181324695967, 731.2614259597791, 808.458332916947, 825.69449303758, 893.423741686615, 932.9720108396759, 8950.015498295183, 8957.417767845069, 8958.10418958112, 8974.237189838872, 8989.190972812414, 4015.457913181683, 4089.589091763337, 4114.259433302034, 4145.398917156996, 4186.518550366686, 8198.918010819934, 8215.137410571804, 8236.958815205886, 8299.336053115858, 8305.750827475185, 4285.078708077778, 4293.355996600535, 4294.26997410441, 4295.0, 4301.526832048472, 3870.651641352292, 3876.1278712290073, 3882.514685664292, 3906.5898080701686, 3908.863189788344, 3330.550375699298, 3402.2515046689687, 3408.705031660126, 3411.812350320756, 3434.364642541088, 1060.0777323728405, 1069.8181309177457, 1079.611339917629, 1082.1667316166665, 1084.8210045342587, 1131.3212072756444, 1140.0651465797966, 1162.4943149729895, 1165.6036947437913, 1166.4342793745027, 6481.708323125471, 6777.1189745332795, 6976.441884649216, 6991.755288564876, 7017.7192912282935, 1040.573364920379, 1041.4584416103585, 1043.9478026098664, 1056.4242487844144, 1064.4305296666246, 4942.357493525818, 5244.396894357198, 5317.8404647860625, 5326.36083669962, 5333.200019996954, 7479.401647868158, 8056.798580035546, 8098.595070246464, 8125.715599953974, 8142.592870356459, 8003.119656837744, 8055.436119471581, 8055.879161812578, 8074.313683336864, 8076.515409075474, 6655.367740064686, 6872.553284036521, 6879.759208427781, 6914.861702765917, 6918.169819621678, 6831.351021652935, 6831.89752153728, 6845.931540684529, 6859.657017149023, 6861.55399899005, 7407.296306850841, 7599.924000759922, 7640.8471830564185, 7666.041744781903, 7674.0, 7164.9641751790905, 7321.707131714672, 7342.449316301192, 7433.10802703679, 7433.628318584158, 6099.817005489843, 6105.542084343603, 6170.136180934763, 6179.81460556184, 6199.5040396767245, 6782.220044694726, 6821.8635627286185, 6837.726490940506, 6840.931590684029, 6843.8973415399805, 6377.5712810737905, 6439.549231553746, 6514.9348506514325, 6515.967420163059, 6575.0, 6416.422521973045, 6426.807195784134, 6432.45324147434, 6495.577787443801, 6538.83652908662, 6437.839054023687, 6463.903041454476, 6481.254655714653, 6481.546291759531, 6488.221413430419, 5559.27729395176, 5683.658980461186, 5926.555508336805, 5983.072623743326, 5994.07091900756, 6020.157177994996, 6058.7273572688455, 6071.7571297147615, 6077.544184186116, 6091.543134265036], "unit": "ms", "name": "mootools.html", "value": 4082.094209496755}, {"lowerIsBetter": false, "replicates": [303.6189582074496, 305.7019406079073, 309.20688434166345, 310.379241516966, 310.5543545012908, 5231.764570594323, 5262.0, 5377.059014672436, 5398.811041613544, 5405.027095122877, 5223.608229382792, 5323.254744335796, 5323.893522129565, 5326.360836699601, 5340.118880384732, 3876.6511014008734, 3971.7418367806144, 4138.0, 4151.771652559108, 4155.898686847988, 4004.159126583421, 4114.958850411487, 4128.133092050658, 4129.277376459123, 4133.677223288549, 4070.043539768152, 4081.4081958116053, 4086.4687590613325, 4086.8569600064, 4092.7953602319767, 3840.8847734568008, 3952.6442620164034, 3973.106051138471, 4046.433499310099, 4075.6331930126285, 3530.38218311797, 3538.239278555123, 3549.5563054618174, 3565.286942611488, 3572.0, 5115.974420127875, 5116.386033675945, 5119.718415487147, 5123.538881500683, 5124.0776660201145, 4665.183592871234, 4675.95324046762, 4676.789544470473, 4685.695429797086, 4686.0, 5386.649867758622, 5551.639143455663, 5558.305211848519, 5576.749046292926, 5578.274824272859, 3862.9227415451533, 3869.071422858522, 3869.9226015479812, 3871.0709429736944, 3873.2447172801317, 5772.509336706385, 5811.476967072984, 5851.678157701367, 5861.6189947653265, 5868.911966320508, 3976.622220889011, 3983.521977362735, 3987.521497420328, 3988.7806170660892, 4002.7198096133575, 3917.6082391761165, 4037.0, 4037.8990525237105, 4040.0909795295825, 4045.0494133878515, 4636.721796692209, 4638.373819534319, 4639.582437580567, 4645.581897629229, 4652.604528615038, 5591.552675785927, 5597.440255974451, 5603.495685388253, 5611.579131565149, 5614.719264036782, 1407.7043820797542, 1428.4286285485682, 1429.4353730276482, 1429.892758043151, 1431.8210223722035, 919.5769945824861, 927.9628814847331, 940.238406890421, 945.2485274207022, 959.8944116147218, 4884.853454396374, 4891.290762839369, 4893.535114164149, 4893.828715994923, 4896.1921282987905, 5799.971000144972, 5805.10020946754, 5811.77952629944, 5812.041013232853, 5812.7674893003805, 4884.3161957326, 4893.804247830119, 4894.2658601210105, 4897.41231052276, 4900.044491324157, 2869.2253091665134, 2989.9402011959637, 3077.353755711326, 3099.4421004219007, 3130.233092892256, 5436.6194366393975, 5510.586705996986, 5511.0080185566185, 5514.558835293167, 5518.117101263859, 6004.519638428916, 6012.969935150384, 6014.6391216527145, 6016.0, 6016.736485338128, 5511.476409741148, 5522.751476183501, 5525.419830917856, 5528.474794894479, 5528.5024347808085, 5709.115087161496, 5842.065269556851, 5855.502282306052, 5856.0630299151935, 5856.472917437451, 5738.1679656450415, 5746.827595172152, 5747.827565173052, 5760.135979603093, 5765.250517432707, 5511.641743286834, 5523.8895222096135, 5527.944720552904, 5530.806421775219, 5537.446255374431, 3866.207427477304, 3979.6617287529725, 4015.0765323975065, 4015.8393664253103, 4024.91950161001, 5727.0550359190265, 5749.626274292157, 5798.913016304843, 5801.100829371454, 5803.390643982321, 5525.392206857323, 5574.108142697149, 5577.051901176728, 5586.13414920688, 5587.161925711176, 5553.0559804832465, 5559.972200138974, 5566.332040155207, 5568.053430916673, 5577.414371490935, 5324.281222034976, 5440.156775699773, 5449.073657478318, 5451.536619387396, 5455.809046683347, 5601.075822489243, 5617.359840874782, 5623.2408624835125, 5630.408807075362, 5631.070873305859, 5303.681779093266, 5386.946130538645, 5441.83674489766, 5532.612717109924, 5543.029969755196], "unit": "ms", "name": "prototype.html", "value": 4182.787324778398}, {"lowerIsBetter": false, "replicates": [665.4776000839342, 684.0764967294153, 727.9417646588273, 750.9586972716501, 760.942929280304, 11612.535498580057, 11763.588274410396, 11815.350155741431, 11827.881721182786, 11849.822252666218, 11608.245464044852, 11856.644300670972, 13127.737445251089, 13243.404046817916, 13274.535391261308, 624.7438550194421, 779.2635959018744, 794.1304271822345, 794.4161041634394, 794.7655441644699, 625.7465726380823, 778.5601135358532, 795.2286282306154, 795.4392153531775, 796.1361922314296, 827.3339961331126, 840.9992109389838, 841.1168273313027, 841.5077179849765, 841.5918279634403, 644.7453255963892, 651.8859199640092, 826.2398593294183, 828.2959484438239, 834.8038211020405, 620.3610281410155, 620.4385031546458, 620.5780069552702, 620.5966122020677, 621.0311913415087, 12377.319247441386, 12491.437885295183, 12516.311602861839, 12522.311272879988, 12524.624261272176, 11150.49822757978, 11594.47824847884, 11618.186726929118, 11826.172167948247, 11905.16663833532, 9323.533823308808, 9350.719478415658, 9409.576569054409, 9426.245900327956, 9455.621775128986, 3185.4106990206888, 3206.422843888099, 3248.1717162123746, 3255.8372081395837, 3275.21394865233, 40747.0, 40826.591734082576, 41221.79389103036, 41339.173216535804, 41464.792676036726, 8790.42862213954, 8936.687215947411, 8950.373473856767, 9004.144606262395, 9054.637814487478, 17163.141842907804, 17187.0, 17222.91388543049, 17241.56896077608, 17258.741118883227, 6514.739410423625, 6597.571157874723, 6699.229588597276, 6717.093192419059, 6890.621015844176, 3511.613722490524, 3533.7879727215936, 3604.513390692223, 3625.148090198801, 3628.600853906068, 2717.6059471376934, 2742.602322663203, 2742.8765705543296, 2747.697753247141, 2752.174347695683, 478.5955867292202, 482.1201307613549, 484.4428906757257, 490.33314692018826, 493.0557981465453, 445.48323944224546, 539.7813885376429, 576.2537513919401, 577.1890493856139, 596.883607696495, 7163.785086447415, 7253.0, 7256.346928776436, 7267.63661816907, 7362.7423040193335, 416.03272391689444, 471.1636844600861, 519.550588740744, 550.8182299841043, 554.4372461951123, 3214.533892585562, 3451.3442445935193, 3485.546878905726, 3510.947335789965, 3558.626344233818, 49634.75913102129, 50547.747261264194, 52451.85288882679, 52869.471305287225, 53022.469775302525, 42297.57702422998, 43132.0, 43153.136937261705, 43419.0, 43548.0, 40676.59323406728, 40958.18083638311, 41522.79238603788, 42101.36847947344, 42128.57871421308, 7947.483413578099, 8169.346452283684, 8315.667373305, 8373.371997100363, 8534.871976920227, 30634.387312253184, 30829.845850770602, 31204.687953120178, 31293.8435307822, 31599.684003160593, 37458.812705936296, 37579.62420375871, 40082.799586001885, 40290.798546007085, 40561.79719101386, 9923.553440095357, 9945.850812237677, 9990.650327238513, 9997.950010249902, 10196.745081373025, 11318.32090074598, 11422.543098275975, 11598.94200528992, 11625.709357266136, 11736.354500502213, 9927.40435573868, 10197.18422526211, 10208.795824083329, 10345.224108191765, 10731.40977246259, 10592.470376481298, 10695.090917271807, 10792.460376981277, 10853.34879907208, 10858.294210876267, 7910.765041679472, 9077.183053525214, 9311.674091406769, 9482.762930926781, 9661.806763864824, 8581.2705919995, 8963.82072358536, 9135.680251191176, 9140.497272650067, 9220.953895230748, 8772.78068048304, 9151.110777919224, 9299.953500232456, 9332.860007100035, 9408.388454750419], "unit": "ms", "name": "yui.html", "value": 5669.039709561993}], "name": "dromaeo_css", "value": 6385.1024607403215}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 106.0, 112.0, 113.0, 113.0, 102.0, 114.0, 119.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 156.0, 169.0, 129.0, 149.0, 160.0, 133.0, 179.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 159.0, 159.0, 162.0, 163.0, 162.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 161.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 92.0, 73.0, 71.0, 72.0, 110.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 134.0, 94.0, 95.0, 95.0, 128.0, 95.0, 94.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 148.0, 146.0, 147.0, 146.0, 148.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 72.0, 71.0, 78.0, 71.0, 79.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 86.0, 85.0, 84.0, 85.0, 86.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.0}, {"lowerIsBetter": true, "replicates": [120.0, 132.0, 126.0, 118.0, 125.0, 121.0, 116.0, 130.0, 119.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.4}, {"lowerIsBetter": true, "replicates": [163.0, 145.0, 148.0, 136.0, 149.0, 134.0, 147.0, 146.0, 137.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.3}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 70.0, 69.0, 70.0, 68.0, 67.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1523.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "Richards", "value": 213.25938200000004}, {"lowerIsBetter": false, "replicates": [184.84288354898337], "unit": "score", "name": "DeltaBlue", "value": 357.6983799999999}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2109.7046413502107], "unit": "score", "name": "RayTrace", "value": 350.7547860000002}, {"lowerIsBetter": false, "replicates": [795.5449482895783], "unit": "score", "name": "Earley", "value": 837.743991}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [626.5664160401003], "unit": "score", "name": "Splay", "value": 130.05963599999995}, {"lowerIsBetter": false, "replicates": [4864.077669902913], "unit": "score", "name": "NavierStokes", "value": 305.0938123752493}], "name": "v8_7", "value": 19613.416534285956}]} 10:32:39 INFO - RETURN: dromaeo_css: 6385.10 10:32:39 INFO - RETURN: kraken: 1523.00 10:32:39 INFO - RETURN: v8_7: 19613.42 10:32:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19613.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1523.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6385.10"}}} 10:32:39 INFO - Return code: 0 10:32:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:32:39 INFO - # TBPL SUCCESS # 10:32:39 INFO - Running post-action listener: _resource_record_post_action 10:32:39 INFO - Running post-run listener: _resource_record_post_run 10:32:40 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511279104; Read time: 12; Write time: 473952 10:32:40 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235085824; Read time: 0; Write time: 334768 10:32:40 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275304448; Read time: 12; Write time: 138092 10:32:40 INFO - Running post-run listener: _upload_blobber_files 10:32:40 INFO - Blob upload gear active. 10:32:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:32:40 INFO - Copying logs to upload dir... 10:32:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.816047 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-12-03 10:32:38.990402) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:32:38.993911) ========= 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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009961 build_url: 'https://queue.taskcluster.net/v1/task/FUylA3uxTaO4NiZPVaEkdA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 10:32:39.046421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:32:39.046804) ========= 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=b00de3c228505fac2445e70d000001bb-1449166292.787775-1031488843 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 10:32:39.097566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 10:32:39.098276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 10:32:39.098923) ========= ========= Total master_lag: 0.25 =========