builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1467114547.29 results: success (0) buildid: 20160628014605 builduid: afe02fc564fd4530a40f2ef0f140d030 revision: 1d4ceb3c5d5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.293290) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.293856) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.294200) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.306545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.306888) ========= 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=836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 04:49:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-28 04:49:08 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.436641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.437074) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020659 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:07.488122) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 04:49:07.488501) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1d4ceb3c5d5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 1d4ceb3c5d5a --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=836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 04:49:08,650 Setting DEBUG logging. 2016-06-28 04:49:08,650 attempt 1/10 2016-06-28 04:49:08,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1d4ceb3c5d5a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 04:49:09,409 unpacking tar archive at: fx-team-1d4ceb3c5d5a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.124013 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 04:49:08.627071) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:08.627480) ========= script_repo_revision: 1d4ceb3c5d5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:08.627977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:08.628315) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:49:08.638056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-28 04:49:08.638378) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:49:09 INFO - MultiFileLogger online at 20160628 04:49:09 in /builds/slave/test 04:49:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:49:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:49:09 INFO - {'append_to_log': False, 04:49:09 INFO - 'base_work_dir': '/builds/slave/test', 04:49:09 INFO - 'blob_upload_branch': 'Fx-Team', 04:49:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:49:09 INFO - 'branch': 'Fx-Team', 04:49:09 INFO - 'buildbot_json_path': 'buildprops.json', 04:49:09 INFO - 'config_files': ('talos/linux_config.py',), 04:49:09 INFO - 'default_actions': ('clobber', 04:49:09 INFO - 'read-buildbot-config', 04:49:09 INFO - 'download-and-extract', 04:49:09 INFO - 'populate-webroot', 04:49:09 INFO - 'create-virtualenv', 04:49:09 INFO - 'install', 04:49:09 INFO - 'run-tests'), 04:49:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:49:09 INFO - 'download_minidump_stackwalk': True, 04:49:09 INFO - 'download_symbols': 'ondemand', 04:49:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:49:09 INFO - 'tooltool.py': '/tools/tooltool.py', 04:49:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:49:09 INFO - '/tools/misc-python/virtualenv.py')}, 04:49:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:49:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:49:09 INFO - 'installer_path': 'installer.exe', 04:49:09 INFO - 'log_level': 'info', 04:49:09 INFO - 'log_name': 'talos', 04:49:09 INFO - 'log_to_console': True, 04:49:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:49:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:49:09 INFO - 'opt_config_files': (), 04:49:09 INFO - 'pip_index': False, 04:49:09 INFO - 'sps_profile': False, 04:49:09 INFO - 'sps_profile_interval': 0, 04:49:09 INFO - 'suite': 'dromaeojs', 04:49:09 INFO - 'system_bits': '32', 04:49:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:49:09 INFO - 'title': 'talos-linux64-ix-028', 04:49:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:49:09 INFO - 'use_talos_json': True, 04:49:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:49:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:49:09 INFO - 'work_dir': 'build'} 04:49:09 INFO - ##### 04:49:09 INFO - ##### Running clobber step. 04:49:09 INFO - ##### 04:49:09 INFO - Running pre-action listener: _resource_record_pre_action 04:49:09 INFO - Running main action method: clobber 04:49:09 INFO - rmtree: /builds/slave/test/build 04:49:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:49:10 INFO - Running post-action listener: _resource_record_post_action 04:49:10 INFO - ##### 04:49:10 INFO - ##### Finished clobber step (success) 04:49:10 INFO - ##### 04:49:10 INFO - ##### 04:49:10 INFO - ##### Running read-buildbot-config step. 04:49:10 INFO - ##### 04:49:10 INFO - Running pre-action listener: _resource_record_pre_action 04:49:10 INFO - Running main action method: read_buildbot_config 04:49:10 INFO - Using buildbot properties: 04:49:10 INFO - { 04:49:10 INFO - "project": "", 04:49:10 INFO - "product": "firefox", 04:49:10 INFO - "script_repo_revision": "production", 04:49:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:49:10 INFO - "repository": "", 04:49:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:49:10 INFO - "buildid": "20160628014605", 04:49:10 INFO - "pgo_build": "True", 04:49:10 INFO - "basedir": "/builds/slave/test", 04:49:10 INFO - "buildnumber": 1286, 04:49:10 INFO - "slavename": "talos-linux64-ix-028", 04:49:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:49:10 INFO - "platform": "ubuntu64_hw", 04:49:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:49:10 INFO - "branch": "fx-team", 04:49:10 INFO - "repo_path": "integration/fx-team", 04:49:10 INFO - "revision": "1d4ceb3c5d5a", 04:49:10 INFO - "stage_platform": "linux64-pgo", 04:49:10 INFO - "builduid": "afe02fc564fd4530a40f2ef0f140d030", 04:49:10 INFO - "slavebuilddir": "test" 04:49:10 INFO - } 04:49:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:49:10 INFO - Running post-action listener: _resource_record_post_action 04:49:10 INFO - ##### 04:49:10 INFO - ##### Finished read-buildbot-config step (success) 04:49:10 INFO - ##### 04:49:10 INFO - ##### 04:49:10 INFO - ##### Running download-and-extract step. 04:49:10 INFO - ##### 04:49:10 INFO - Running pre-action listener: _resource_record_pre_action 04:49:10 INFO - Running main action method: download_and_extract 04:49:10 INFO - mkdir: /builds/slave/test/build/tests 04:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:10 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:49:10 INFO - Downloaded 1361 bytes. 04:49:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:49:10 INFO - Using the following test package requirements: 04:49:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:49:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:49:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:49:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'jsshell-linux-x86_64.zip'], 04:49:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:49:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:49:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:49:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:49:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:49:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:49:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:49:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:10 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:49:12 INFO - Downloaded 24279844 bytes. 04:49:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:49:13 INFO - Return code: 0 04:49:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:49:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:13 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:49:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:49:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:49:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:49:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:49:15 INFO - Downloaded 24279844 bytes. 04:49:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:49:16 INFO - Return code: 0 04:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:16 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:49:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:49:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:49:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:49:18 INFO - Downloaded 14405245 bytes. 04:49:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:49:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:49:18 INFO - Return code: 0 04:49:18 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')]} 04:49:18 INFO - https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:49:19 INFO - Downloaded 60307221 bytes. 04:49:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:49:19 INFO - mkdir: /builds/slave/test/properties 04:49:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:19 INFO - Contents: 04:49:19 INFO - build_url:https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:49:20 INFO - Running post-action listener: _resource_record_post_action 04:49:20 INFO - Running post-action listener: set_extra_try_arguments 04:49:20 INFO - ##### 04:49:20 INFO - ##### Finished download-and-extract step (success) 04:49:20 INFO - ##### 04:49:20 INFO - ##### 04:49:20 INFO - ##### Running populate-webroot step. 04:49:20 INFO - ##### 04:49:20 INFO - Running pre-action listener: _resource_record_pre_action 04:49:20 INFO - Running main action method: populate_webroot 04:49:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:20 INFO - '--tppagecycles', 04:49:20 INFO - '7'], 04:49:20 INFO - 'tests': ['tsvgm']}}, 04:49:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['damp', 'tps']}, 04:49:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'tests': ['damp', 'tps']}, 04:49:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['dromaeo_dom']}, 04:49:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['basic_compositor_video']}, 04:49:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:49:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['a11yr', 04:49:20 INFO - 'ts_paint', 04:49:20 INFO - 'tpaint', 04:49:20 INFO - 'sessionrestore', 04:49:20 INFO - 'sessionrestore_no_auto_restore', 04:49:20 INFO - 'tabpaint']}, 04:49:20 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:20 INFO - 'ts_paint', 04:49:20 INFO - 'tpaint', 04:49:20 INFO - 'sessionrestore', 04:49:20 INFO - 'sessionrestore_no_auto_restore', 04:49:20 INFO - 'tabpaint']}, 04:49:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:20 INFO - 'ts_paint', 04:49:20 INFO - 'tpaint', 04:49:20 INFO - 'sessionrestore', 04:49:20 INFO - 'sessionrestore_no_auto_restore', 04:49:20 INFO - 'tabpaint']}, 04:49:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:20 INFO - 'ts_paint', 04:49:20 INFO - 'tpaint', 04:49:20 INFO - 'sessionrestore', 04:49:20 INFO - 'sessionrestore_no_auto_restore', 04:49:20 INFO - 'tabpaint']}, 04:49:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['a11yr', 04:49:20 INFO - 'ts_paint', 04:49:20 INFO - 'tpaint', 04:49:20 INFO - 'sessionrestore', 04:49:20 INFO - 'sessionrestore_no_auto_restore', 04:49:20 INFO - 'tabpaint']}, 04:49:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['a11yr', 04:49:20 INFO - 'ts_paint', 04:49:20 INFO - 'tpaint', 04:49:20 INFO - 'sessionrestore', 04:49:20 INFO - 'sessionrestore_no_auto_restore', 04:49:20 INFO - 'tabpaint']}, 04:49:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['tsvgx', 04:49:20 INFO - 'tsvgr_opacity', 04:49:20 INFO - 'tart', 04:49:20 INFO - 'tscrollx', 04:49:20 INFO - 'cart']}, 04:49:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:20 INFO - 'tsvgr_opacity', 04:49:20 INFO - 'tart', 04:49:20 INFO - 'tscrollx', 04:49:20 INFO - 'cart']}, 04:49:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'talos_options': ['--disable-e10s'], 04:49:20 INFO - 'tests': ['tp5o']}, 04:49:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'tests': ['tp5o']}, 04:49:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'talos_options': ['--disable-e10s', 04:49:20 INFO - '--xperf_path', 04:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:20 INFO - 'tests': ['tp5n']}, 04:49:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:49:20 INFO - 'talos_options': ['--xperf_path', 04:49:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:20 INFO - 'tests': ['tp5n']}}, 04:49:20 INFO - 'talos.zip': {'path': '', 04:49:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:20 INFO - Running post-action listener: _resource_record_post_action 04:49:20 INFO - ##### 04:49:20 INFO - ##### Finished populate-webroot step (success) 04:49:20 INFO - ##### 04:49:20 INFO - ##### 04:49:20 INFO - ##### Running create-virtualenv step. 04:49:20 INFO - ##### 04:49:20 INFO - Running pre-action listener: _resource_record_pre_action 04:49:20 INFO - Running main action method: create_virtualenv 04:49:20 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:20 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 04:49:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:20 INFO - Using real prefix '/usr' 04:49:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:21 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:23 INFO - Installing pip.................done. 04:49:23 INFO - Return code: 0 04:49:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:49:23 INFO - Using env: {'DISPLAY': ':0', 04:49:23 INFO - 'HOME': '/home/cltbld', 04:49:23 INFO - 'LANG': 'en_US.UTF-8', 04:49:23 INFO - 'LANGUAGE': 'en_US:en', 04:49:23 INFO - 'LOGNAME': 'cltbld', 04:49:23 INFO - 'MAIL': '/var/mail/cltbld', 04:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:23 INFO - 'MOZ_NO_REMOTE': '1', 04:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:23 INFO - 'NO_EM_RESTART': '1', 04:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:23 INFO - 'PWD': '/builds/slave/test', 04:49:23 INFO - 'SHELL': '/bin/bash', 04:49:23 INFO - 'SHLVL': '1', 04:49:23 INFO - 'TERM': 'linux', 04:49:23 INFO - 'TMOUT': '86400', 04:49:23 INFO - 'USER': 'cltbld', 04:49:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:23 INFO - '_': '/tools/buildbot/bin/python'} 04:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:23 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 04:49:23 INFO - Cleaning up... 04:49:23 INFO - Return code: 0 04:49:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 04:49:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 04:49:23 INFO - Using env: {'DISPLAY': ':0', 04:49:23 INFO - 'HOME': '/home/cltbld', 04:49:23 INFO - 'LANG': 'en_US.UTF-8', 04:49:23 INFO - 'LANGUAGE': 'en_US:en', 04:49:23 INFO - 'LOGNAME': 'cltbld', 04:49:23 INFO - 'MAIL': '/var/mail/cltbld', 04:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:23 INFO - 'MOZ_NO_REMOTE': '1', 04:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:23 INFO - 'NO_EM_RESTART': '1', 04:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:23 INFO - 'PWD': '/builds/slave/test', 04:49:23 INFO - 'SHELL': '/bin/bash', 04:49:23 INFO - 'SHLVL': '1', 04:49:23 INFO - 'TERM': 'linux', 04:49:23 INFO - 'TMOUT': '86400', 04:49:23 INFO - 'USER': 'cltbld', 04:49:23 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:23 INFO - '_': '/tools/buildbot/bin/python'} 04:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:23 INFO - Downloading/unpacking psutil>=3.1.1 04:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:25 INFO - Installing collected packages: psutil 04:49:25 INFO - Running setup.py install for psutil 04:49:25 INFO - building 'psutil._psutil_linux' extension 04:49:25 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 04:49:25 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 04:49:26 INFO - building 'psutil._psutil_posix' extension 04:49:26 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 04:49:26 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 04:49:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:26 INFO - Successfully installed psutil 04:49:26 INFO - Cleaning up... 04:49:26 INFO - Return code: 0 04:49:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 04:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 04:49:26 INFO - Using env: {'DISPLAY': ':0', 04:49:26 INFO - 'HOME': '/home/cltbld', 04:49:26 INFO - 'LANG': 'en_US.UTF-8', 04:49:26 INFO - 'LANGUAGE': 'en_US:en', 04:49:26 INFO - 'LOGNAME': 'cltbld', 04:49:26 INFO - 'MAIL': '/var/mail/cltbld', 04:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:26 INFO - 'MOZ_NO_REMOTE': '1', 04:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:26 INFO - 'NO_EM_RESTART': '1', 04:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:26 INFO - 'PWD': '/builds/slave/test', 04:49:26 INFO - 'SHELL': '/bin/bash', 04:49:26 INFO - 'SHLVL': '1', 04:49:26 INFO - 'TERM': 'linux', 04:49:26 INFO - 'TMOUT': '86400', 04:49:26 INFO - 'USER': 'cltbld', 04:49:26 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:26 INFO - '_': '/tools/buildbot/bin/python'} 04:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:28 INFO - Installing collected packages: mozsystemmonitor 04:49:28 INFO - Running setup.py install for mozsystemmonitor 04:49:28 INFO - Successfully installed mozsystemmonitor 04:49:28 INFO - Cleaning up... 04:49:28 INFO - Return code: 0 04:49:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 04:49:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 04:49:28 INFO - Using env: {'DISPLAY': ':0', 04:49:28 INFO - 'HOME': '/home/cltbld', 04:49:28 INFO - 'LANG': 'en_US.UTF-8', 04:49:28 INFO - 'LANGUAGE': 'en_US:en', 04:49:28 INFO - 'LOGNAME': 'cltbld', 04:49:28 INFO - 'MAIL': '/var/mail/cltbld', 04:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:28 INFO - 'MOZ_NO_REMOTE': '1', 04:49:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:28 INFO - 'NO_EM_RESTART': '1', 04:49:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:28 INFO - 'PWD': '/builds/slave/test', 04:49:28 INFO - 'SHELL': '/bin/bash', 04:49:28 INFO - 'SHLVL': '1', 04:49:28 INFO - 'TERM': 'linux', 04:49:28 INFO - 'TMOUT': '86400', 04:49:28 INFO - 'USER': 'cltbld', 04:49:28 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:28 INFO - '_': '/tools/buildbot/bin/python'} 04:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:28 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 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 04:49:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:31 INFO - warning: no files found matching '*.txt' 04:49:31 INFO - no previously-included directories found matching 'build' 04:49:31 INFO - no previously-included directories found matching 'dist' 04:49:31 INFO - no previously-included directories found matching '.git*' 04:49:31 INFO - Installing collected packages: jsonschema, functools32 04:49:31 INFO - Running setup.py install for functools32 04:49:31 INFO - warning: no files found matching '*.txt' 04:49:31 INFO - no previously-included directories found matching 'build' 04:49:31 INFO - no previously-included directories found matching 'dist' 04:49:31 INFO - no previously-included directories found matching '.git*' 04:49:31 INFO - Successfully installed jsonschema functools32 04:49:31 INFO - Cleaning up... 04:49:31 INFO - Return code: 0 04:49:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:49:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:49:31 INFO - Using env: {'DISPLAY': ':0', 04:49:31 INFO - 'HOME': '/home/cltbld', 04:49:31 INFO - 'LANG': 'en_US.UTF-8', 04:49:31 INFO - 'LANGUAGE': 'en_US:en', 04:49:31 INFO - 'LOGNAME': 'cltbld', 04:49:31 INFO - 'MAIL': '/var/mail/cltbld', 04:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:31 INFO - 'MOZ_NO_REMOTE': '1', 04:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:31 INFO - 'NO_EM_RESTART': '1', 04:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:31 INFO - 'PWD': '/builds/slave/test', 04:49:31 INFO - 'SHELL': '/bin/bash', 04:49:31 INFO - 'SHLVL': '1', 04:49:31 INFO - 'TERM': 'linux', 04:49:31 INFO - 'TMOUT': '86400', 04:49:31 INFO - 'USER': 'cltbld', 04:49:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:31 INFO - '_': '/tools/buildbot/bin/python'} 04:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:31 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:31 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 04:49:31 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 04:49:31 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 04:49:31 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 04:49:31 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 04:49:31 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 04:49:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:33 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 04:49:34 INFO - Downloading docopt-0.6.1.tar.gz 04:49:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:34 INFO - Running setup.py install for blobuploader 04:49:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:34 INFO - Running setup.py install for requests 04:49:34 INFO - Running setup.py install for docopt 04:49:34 INFO - Successfully installed blobuploader requests docopt 04:49:34 INFO - Cleaning up... 04:49:34 INFO - Return code: 0 04:49:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 04:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 04:49:34 INFO - Using env: {'DISPLAY': ':0', 04:49:34 INFO - 'HOME': '/home/cltbld', 04:49:34 INFO - 'LANG': 'en_US.UTF-8', 04:49:34 INFO - 'LANGUAGE': 'en_US:en', 04:49:34 INFO - 'LOGNAME': 'cltbld', 04:49:34 INFO - 'MAIL': '/var/mail/cltbld', 04:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:34 INFO - 'MOZ_NO_REMOTE': '1', 04:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:34 INFO - 'NO_EM_RESTART': '1', 04:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:34 INFO - 'PWD': '/builds/slave/test', 04:49:34 INFO - 'SHELL': '/bin/bash', 04:49:34 INFO - 'SHLVL': '1', 04:49:34 INFO - 'TERM': 'linux', 04:49:34 INFO - 'TMOUT': '86400', 04:49:34 INFO - 'USER': 'cltbld', 04:49:34 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:34 INFO - '_': '/tools/buildbot/bin/python'} 04:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:34 INFO - Running setup.py (path:/tmp/pip-7wRuAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:34 INFO - Running setup.py (path:/tmp/pip-C1RVTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:35 INFO - Running setup.py (path:/tmp/pip-kbK5ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:35 INFO - Running setup.py (path:/tmp/pip-KpZuk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:35 INFO - Running setup.py (path:/tmp/pip-UQHNVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:35 INFO - Running setup.py (path:/tmp/pip-8reCIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:35 INFO - Running setup.py (path:/tmp/pip-TjQ9uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:35 INFO - Running setup.py (path:/tmp/pip-qoFzCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:35 INFO - Running setup.py (path:/tmp/pip-IhswUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:35 INFO - Running setup.py (path:/tmp/pip-b3ktWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:35 INFO - Running setup.py (path:/tmp/pip-MmmEGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:35 INFO - Running setup.py (path:/tmp/pip-ix8YdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:35 INFO - Running setup.py (path:/tmp/pip-haqXyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:35 INFO - Running setup.py (path:/tmp/pip-kChIu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:35 INFO - Running setup.py (path:/tmp/pip-D2Bokc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:36 INFO - Running setup.py (path:/tmp/pip-SlTKnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:36 INFO - Running setup.py (path:/tmp/pip-ETB20N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:49:36 INFO - Running setup.py install for manifestparser 04:49:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Running setup.py install for mozcrash 04:49:36 INFO - Running setup.py install for mozdebug 04:49:36 INFO - Running setup.py install for mozdevice 04:49:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Running setup.py install for mozfile 04:49:36 INFO - Running setup.py install for mozhttpd 04:49:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Running setup.py install for mozinfo 04:49:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Running setup.py install for mozInstall 04:49:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:49:36 INFO - Running setup.py install for mozleak 04:49:37 INFO - Running setup.py install for mozlog 04:49:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for moznetwork 04:49:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for mozprocess 04:49:37 INFO - Running setup.py install for mozprofile 04:49:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for mozrunner 04:49:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Running setup.py install for mozscreenshot 04:49:37 INFO - Running setup.py install for moztest 04:49:37 INFO - Running setup.py install for mozversion 04:49:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:49:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:49:37 INFO - Cleaning up... 04:49:37 INFO - Return code: 0 04:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:49:37 INFO - Using env: {'DISPLAY': ':0', 04:49:37 INFO - 'HOME': '/home/cltbld', 04:49:37 INFO - 'LANG': 'en_US.UTF-8', 04:49:37 INFO - 'LANGUAGE': 'en_US:en', 04:49:37 INFO - 'LOGNAME': 'cltbld', 04:49:37 INFO - 'MAIL': '/var/mail/cltbld', 04:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:37 INFO - 'MOZ_NO_REMOTE': '1', 04:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:37 INFO - 'NO_EM_RESTART': '1', 04:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:37 INFO - 'PWD': '/builds/slave/test', 04:49:37 INFO - 'SHELL': '/bin/bash', 04:49:37 INFO - 'SHLVL': '1', 04:49:37 INFO - 'TERM': 'linux', 04:49:37 INFO - 'TMOUT': '86400', 04:49:37 INFO - 'USER': 'cltbld', 04:49:37 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:37 INFO - '_': '/tools/buildbot/bin/python'} 04:49:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:49:38 INFO - Running setup.py (path:/tmp/pip-XK9A7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:49:38 INFO - Running setup.py (path:/tmp/pip-5jmWBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:49:38 INFO - Running setup.py (path:/tmp/pip-oIQ1DA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:49:38 INFO - Running setup.py (path:/tmp/pip-uAQ8Zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:49:38 INFO - Running setup.py (path:/tmp/pip-yqUUsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:49:38 INFO - Running setup.py (path:/tmp/pip-qhMkbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:49:38 INFO - Running setup.py (path:/tmp/pip-EEKAbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:49:38 INFO - Running setup.py (path:/tmp/pip-v2OBDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:49:38 INFO - Running setup.py (path:/tmp/pip-gx7SC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:49:38 INFO - Running setup.py (path:/tmp/pip-Emm_wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:49:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:49:38 INFO - Running setup.py (path:/tmp/pip-uNXpky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:49:38 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)) 04:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:49:38 INFO - Running setup.py (path:/tmp/pip-1MTrvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:49:39 INFO - Running setup.py (path:/tmp/pip-u7eSVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:49:39 INFO - Running setup.py (path:/tmp/pip-hfCeSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:39 INFO - Running setup.py (path:/tmp/pip-JMNmph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:49:39 INFO - Running setup.py (path:/tmp/pip-YY5wzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:49:39 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)) 04:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:49:39 INFO - Running setup.py (path:/tmp/pip-ctuKnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:49:39 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)) 04:49:39 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:39 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:49:39 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)) 04:49:39 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:39 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:49:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:39 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 04:49:41 INFO - Downloading blessings-1.6.tar.gz 04:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:49:41 INFO - Installing collected packages: blessings 04:49:41 INFO - Running setup.py install for blessings 04:49:41 INFO - Successfully installed blessings 04:49:41 INFO - Cleaning up... 04:49:41 INFO - Return code: 0 04:49:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:41 INFO - Reading from file tmpfile_stdout 04:49:41 INFO - Current package versions: 04:49:41 INFO - argparse == 1.2.1 04:49:41 INFO - blessings == 1.6 04:49:41 INFO - blobuploader == 1.2.4 04:49:41 INFO - docopt == 0.6.1 04:49:41 INFO - functools32 == 3.2.3-2 04:49:41 INFO - jsonschema == 2.5.1 04:49:41 INFO - manifestparser == 1.1 04:49:41 INFO - mozInstall == 1.12 04:49:41 INFO - mozcrash == 0.17 04:49:41 INFO - mozdebug == 0.1 04:49:41 INFO - mozdevice == 0.48 04:49:41 INFO - mozfile == 1.2 04:49:41 INFO - mozhttpd == 0.7 04:49:41 INFO - mozinfo == 0.9 04:49:41 INFO - mozleak == 0.1 04:49:41 INFO - mozlog == 3.2 04:49:41 INFO - moznetwork == 0.27 04:49:41 INFO - mozprocess == 0.22 04:49:41 INFO - mozprofile == 0.28 04:49:41 INFO - mozrunner == 6.11 04:49:41 INFO - mozscreenshot == 0.1 04:49:41 INFO - mozsystemmonitor == 0.3 04:49:41 INFO - moztest == 0.7 04:49:41 INFO - mozversion == 1.4 04:49:41 INFO - psutil == 3.1.1 04:49:41 INFO - requests == 1.2.3 04:49:41 INFO - wsgiref == 0.1.2 04:49:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:49:41 INFO - Using env: {'DISPLAY': ':0', 04:49:41 INFO - 'HOME': '/home/cltbld', 04:49:41 INFO - 'LANG': 'en_US.UTF-8', 04:49:41 INFO - 'LANGUAGE': 'en_US:en', 04:49:41 INFO - 'LOGNAME': 'cltbld', 04:49:41 INFO - 'MAIL': '/var/mail/cltbld', 04:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:41 INFO - 'MOZ_NO_REMOTE': '1', 04:49:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:41 INFO - 'NO_EM_RESTART': '1', 04:49:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:41 INFO - 'PWD': '/builds/slave/test', 04:49:41 INFO - 'SHELL': '/bin/bash', 04:49:41 INFO - 'SHLVL': '1', 04:49:41 INFO - 'TERM': 'linux', 04:49:41 INFO - 'TMOUT': '86400', 04:49:41 INFO - 'USER': 'cltbld', 04:49:41 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:41 INFO - '_': '/tools/buildbot/bin/python'} 04:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:49:41 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 2)) 04:49:41 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 3)) 04:49:41 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 4)) 04:49:41 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 5)) 04:49:41 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 6)) 04:49:41 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 7)) 04:49:41 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 8)) 04:49:41 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 9)) 04:49:41 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:49:41 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 4)) 04:49:41 INFO - Cleaning up... 04:49:41 INFO - Return code: 0 04:49:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:49:42 INFO - Using env: {'DISPLAY': ':0', 04:49:42 INFO - 'HOME': '/home/cltbld', 04:49:42 INFO - 'LANG': 'en_US.UTF-8', 04:49:42 INFO - 'LANGUAGE': 'en_US:en', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MAIL': '/var/mail/cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SHLVL': '1', 04:49:42 INFO - 'TERM': 'linux', 04:49:42 INFO - 'TMOUT': '86400', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - '_': '/tools/buildbot/bin/python'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:49:42 INFO - Cleaning up... 04:49:42 INFO - Return code: 0 04:49:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f8bdc409f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2282590>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, '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': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', '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 04:49:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:49:42 INFO - Using env: {'DISPLAY': ':0', 04:49:42 INFO - 'HOME': '/home/cltbld', 04:49:42 INFO - 'LANG': 'en_US.UTF-8', 04:49:42 INFO - 'LANGUAGE': 'en_US:en', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MAIL': '/var/mail/cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SHLVL': '1', 04:49:42 INFO - 'TERM': 'linux', 04:49:42 INFO - 'TMOUT': '86400', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - '_': '/tools/buildbot/bin/python'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 INFO - Downloading/unpacking flake8 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:49:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:49:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:49:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:45 INFO - no previously-included directories found matching 'docs/_build' 04:49:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:49:45 INFO - Running setup.py install for pep8 04:49:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:49:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:49:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:49:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:49:45 INFO - no previously-included directories found matching 'docs/_build' 04:49:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:49:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:49:45 INFO - Cleaning up... 04:49:45 INFO - Return code: 0 04:49:45 INFO - Running post-action listener: _resource_record_post_action 04:49:45 INFO - Running post-action listener: _start_resource_monitoring 04:49:45 INFO - Starting resource monitoring. 04:49:45 INFO - ##### 04:49:45 INFO - ##### Finished create-virtualenv step (success) 04:49:45 INFO - ##### 04:49:45 INFO - ##### 04:49:45 INFO - ##### Running install step. 04:49:45 INFO - ##### 04:49:45 INFO - Running pre-action listener: _resource_record_pre_action 04:49:45 INFO - Running main action method: install 04:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:49:45 INFO - Reading from file tmpfile_stdout 04:49:45 INFO - Detecting whether we're running mozinstall >=1.0... 04:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:49:45 INFO - Reading from file tmpfile_stdout 04:49:45 INFO - Output received: 04:49:45 INFO - Usage: mozinstall [options] installer 04:49:45 INFO - Options: 04:49:45 INFO - -h, --help show this help message and exit 04:49:45 INFO - -d DEST, --destination=DEST 04:49:45 INFO - Directory to install application into. [default: 04:49:45 INFO - "/builds/slave/test"] 04:49:45 INFO - --app=APP Application being installed. [default: firefox] 04:49:45 INFO - mkdir: /builds/slave/test/build/application 04:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:50:02 INFO - Reading from file tmpfile_stdout 04:50:02 INFO - Output received: 04:50:02 INFO - /builds/slave/test/build/application/firefox/firefox 04:50:02 INFO - Running post-action listener: _resource_record_post_action 04:50:02 INFO - ##### 04:50:02 INFO - ##### Finished install step (success) 04:50:02 INFO - ##### 04:50:02 INFO - ##### 04:50:02 INFO - ##### Running run-tests step. 04:50:02 INFO - ##### 04:50:02 INFO - Running pre-action listener: _resource_record_pre_action 04:50:02 INFO - Running main action method: run_tests 04:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:02 INFO - Python 2.7.3 04:50:02 INFO - Return code: 0 04:50:02 INFO - grabbing minidump binary from tooltool 04:50: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')]} 04:50:02 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2313570>, '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 0x2280610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2280ac0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:02 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 04:50:02 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 04:50:02 INFO - Calling ['/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'] with output_timeout 600 04:50:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:02 INFO - Return code: 0 04:50:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:50:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:50:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:50:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:50:03 INFO - Return code: 0 04:50:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:50:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:50:03 INFO - Using env: {'DISPLAY': ':0', 04:50:03 INFO - 'HOME': '/home/cltbld', 04:50:03 INFO - 'LANG': 'en_US.UTF-8', 04:50:03 INFO - 'LANGUAGE': 'en_US:en', 04:50:03 INFO - 'LOGNAME': 'cltbld', 04:50:03 INFO - 'MAIL': '/var/mail/cltbld', 04:50:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:50:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:03 INFO - 'MOZ_NO_REMOTE': '1', 04:50:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:50:03 INFO - 'NO_EM_RESTART': '1', 04:50:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:50:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:03 INFO - 'PWD': '/builds/slave/test', 04:50:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:03 INFO - 'SHELL': '/bin/bash', 04:50:03 INFO - 'SHLVL': '1', 04:50:03 INFO - 'TERM': 'linux', 04:50:03 INFO - 'TMOUT': '86400', 04:50:03 INFO - 'USER': 'cltbld', 04:50:03 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246', 04:50:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:03 INFO - '_': '/tools/buildbot/bin/python'} 04:50:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:50:03 INFO - mozversion application_buildid: 20160628014605 04:50:03 INFO - mozversion application_changeset: 1d4ceb3c5d5aed6afc6ec71239b2d741df893379 04:50:03 INFO - mozversion application_display_name: Nightly 04:50:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:03 INFO - mozversion application_name: Firefox 04:50:03 INFO - mozversion application_remotingname: firefox 04:50:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:50:03 INFO - mozversion application_vendor: Mozilla 04:50:03 INFO - mozversion application_version: 50.0a1 04:50:03 INFO - mozversion platform_buildid: 20160628014605 04:50:03 INFO - mozversion platform_changeset: 1d4ceb3c5d5aed6afc6ec71239b2d741df893379 04:50:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:50:03 INFO - mozversion platform_version: 50.0a1 04:50:03 INFO - using testdate: 1467114603 04:50:03 INFO - actual date: 1467114603 04:50:03 INFO - starting webserver on 'localhost:46488' 04:50:03 INFO - SUITE-START | Running 2 tests 04:50:03 INFO - TEST-START | dromaeo_css 04:50:03 INFO - operating with platform_type : linux_ 04:50:03 INFO - Initialising browser for dromaeo_css test... 04:50:03 INFO - TEST-INFO | started process 24569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRWtFh2/profile http://localhost:46488/getInfo.html) 04:50:08 INFO - PROCESS | 24569 | __metrics Screen width/height:1600/1200 04:50:08 INFO - PROCESS | 24569 | colorDepth:24 04:50:08 INFO - PROCESS | 24569 | Browser inner width/height: 1024/697 04:50:08 INFO - PROCESS | 24569 | __metrics 04:50:09 INFO - PROCESS | 24569 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:10 INFO - TEST-INFO | 24569: exit 0 04:50:10 INFO - Browser initialized. 04:50:10 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:10 INFO - TEST-INFO | started process 24656 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRWtFh2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:22 INFO - PROCESS | 24656 | RSS: Main: 174190592 04:50:22 INFO - PROCESS | 24656 | 04:51:13 INFO - PROCESS | 24656 | 1467114673124 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] 04:53:22 INFO - PROCESS | 24656 | Cycle 1(1): loaded http://localhost:46488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46488/tests/dromaeo/cssquery-ext.html) 04:53:23 INFO - PROCESS | 24656 | RSS: Main: 296316928 04:53:23 INFO - PROCESS | 24656 | 04:56:25 INFO - PROCESS | 24656 | Cycle 1(1): loaded http://localhost:46488/tests/dromaeo/cssquery-ext.html (next: http://localhost:46488/tests/dromaeo/cssquery-jquery.html) 04:56:26 INFO - PROCESS | 24656 | RSS: Main: 256327680 04:56:26 INFO - PROCESS | 24656 | 04:59:28 INFO - PROCESS | 24656 | Cycle 1(1): loaded http://localhost:46488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46488/tests/dromaeo/cssquery-mootools.html) 04:59:29 INFO - PROCESS | 24656 | RSS: Main: 268730368 04:59:29 INFO - PROCESS | 24656 | 05:02:31 INFO - PROCESS | 24656 | Cycle 1(1): loaded http://localhost:46488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46488/tests/dromaeo/cssquery-prototype.html) 05:02:31 INFO - PROCESS | 24656 | RSS: Main: 254115840 05:02:31 INFO - PROCESS | 24656 | 05:05:34 INFO - PROCESS | 24656 | Cycle 1(1): loaded http://localhost:46488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46488/tests/dromaeo/cssquery-yui.html) 05:05:35 INFO - PROCESS | 24656 | RSS: Main: 239509504 05:05:35 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | Cycle 1(1): loaded http://localhost:46488/tests/dromaeo/cssquery-yui.html (next: http://localhost:46488/tests/dromaeo/cssquery-dojo.html) 05:08:37 INFO - PROCESS | 24656 | RSS: Main: 317108224 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | __start_tp_report 05:08:37 INFO - PROCESS | 24656 | _x_x_mozilla_page_load 05:08:37 INFO - PROCESS | 24656 | _x_x_mozilla_page_load_details 05:08:37 INFO - PROCESS | 24656 | |i|pagename|runs| 05:08:37 INFO - PROCESS | 24656 | |0;dojo.html;3093.5514350419185;3105.95341069884;3122.328699329644;3143.4498962681555;3169.857356418961;5188.48115188481;5278.261043453919;5297.655652382592;5378.951104534617;5389.137737961922;5208.817691380802;5217.973910130453;5289.8942021159555;5319.654222475537;5337.67973921564;4689.859304220862;4729.7635118244125;4752.144613969484;4764.523547645225;4902.289168070628;4837.7822997965;4853.951460485403;4860.222364421693;4861.538153875376;4871.098846713369;4628.490866004737;4672.2057250267535;4678.017616300581;4802.543758342952;4833.685810422311;4629.259318509056;4634.513376095529;4689.62483001359;4738.715677059353;4755.239161734106;4606.147862645421;4607.769611519444;4629.189891768927;4687.015726697397;4724.45668748095;5139.948600514022;5199.714015729133;5209.921851172236;5223.6343455958095;5226;5572.275604171472;5610.046292130348;5624.3250809902665;5651.1523271509195;5704.087346024616;5696.189926108863;5728.054870946289;5737.254156959611;5750.223719797816;5757.136429535603;5168.586513078944;5317.229001794795;5318.202269659543;5362.034833729927;5365.356157261153;5809.041508151107;5875.059990401601;5882.470577647947;5933.258342707161;5933.495652869555;5610.4670056344585;5616.185653080281;5621.80323688669;5666.546676265889;5673.546116310686;5526.171074338801;5536.501714845684;5744.080947048452;5757.712114394263;5767.971160144256;5536.390996990328;5560.221568980346;5562.054450743383;5612.186232996192;5612.887742245132;5549.084401073858;5584.106542953108;5604.131359639263;5604.635698679573;5605.887882242332;4226.344916537942;4277.743335399886;4277.786110694453;4314.654827613784;4345.891352716144;3865.1110244643887;3880.708946828999;3885.0287428142965;3917.9804100979313;3934.940975885364;5361.303030605996;5383.031054410244;5386.084365657847;5394.271773310553;5429.755660995264;5519.116941289374;5595.916061259084;5669.31968163823;5682.090865461506;5722.570807189478;5331.5201631853315;5347.652402593819;5348.171033489815;5355.598330125256;5386.649867758583;4581.587657110876;4590.059037897223;4595.264757638762;4597.977010114995;4626.4910859805395;5654.943450565442;5741.282339707536;5795.681237531976;5804.680742559115;5837.066069428871;5578.63738856973;5610.859728506657;5621.241132447068;5621.353544342453;5626.634268772516;5789.884202315846;5805.622634528742;5837.416258374129;5839.211706419749;5844.795432159854;5429.40276569585;5538.6399884007415;5540.833774986757;5558.277423934863;5607.635503692247;5642.774289028557;5662.546996240373;5675.801346952837;5682.232898558642;5686.9715651421475;5436.184572314184;5527.39198688152;5567.8886422272135;5570.58220633446;5579.246801681883;5352.1971704243115;5381.946180538144;5396.514313711785;5446.319210098738;5470.589705772003;5315.681059136464;5351.438098999549;5355.705436201047;5356.866078348073;5360.3299587551555;5459.39946605881;5499.4225606310765;5519.034169020325;5526.55787536988;5539.612227144061;5333;5382.865428364322;5406.459354064562;5407.351117865881;5480.451954804487 05:08:37 INFO - PROCESS | 24656 | |1;ext.html;579.1862433281241;606.0938896349957;618.5515501261583;626.9592476489031;631.2614241337636;30704.692953070462;43719.56280437195;44391.334129988;44475;44543.55456445439;46395.76802115993;46912.29631555529;46932.53067469324;46956.29565556519;47004.52995470044;8041.919580804205;8362.331013518904;8827.602757875895;8984.19142277195;10586.735331616732;10298.639547615834;10556.049955504002;10728.409937453436;10739.892601074007;10746.247762656618;10700.839487407657;10759.193060520452;10767.676969690921;10812.080973117294;10829.187810914174;8211.548364839931;10695.786084278348;10984.06635435989;10990.065844403236;10991.945040274828;10362.067413932707;10436.112930400925;10437.843432348522;10833;10854.348739075602;43133.35299970503;43655;43681.56318436807;43742.56257437417;43769;3328.9001329959897;3451.930961380758;3453.637368076366;3470.8958731238104;3563.0379797454543;33753.156171095674;34272.143196420286;34509.30981380383;34580.654193457995;35373.11567210814;4285.442892423996;4290.077633308822;4386.934195987031;4474.955250447519;4567.520410356898;352947;354290;357881;358414;359832.20083899674;35171.47242791309;35516.82241588776;35931;63825.36174638287;65103;38365.80817095897;38372;38507.6149238504;38519;38528.80735596304;14002.369893354824;14968.428315026984;15079.43649579574;15084.849151508564;15089.47186848455;12541.498340066477;12670.936645316899;12692.238465692088;13005;13029.413676384585;8539.74380768578;8619.482831030158;8631.913680863237;8670.35263299971;8702.39083264178;3347.3640008398324;3372.8819491317686;3377.594688637379;3382.5624109753257;3415.4023045966856;1024.6157690865925;1041.0953439902737;1086.6033897627467;1131.7679875625477;1181.71048093216;33136.33727325488;33253.3349333012;33786;33874.83062584721;34295.657043429244;1104.9392283424488;1118.8042092633757;1178.3813497913493;1195.8505186851644;1203.2479700187382;17561.824381756018;17729.822701772817;17730.5567360817;17749.29002839872;17865.285388584573;568527;569598;570401;573253;574370;60439.09341359883;60865;61058.38941610527;61137.38862611317;61147.7196596234;1260.7541529401863;1345.7308538292184;1361.224102261721;1364.7611667958067;1390.1450607876286;31014.844925775225;34815.47776783401;35048.12379690528;35066.474002890485;35419.29161416809;52218.738906305225;53049.20426193533;53128.734356329514;53190.73404632952;53278.2008269884;460842;483258;483377;484513;486570;38506.422403663404;43505.34741978809;43840;44995.32507012463;47647;49998.250026248905;50279.49720502748;50450.74774626103;50505.74747126388;51248;41774;42465.15069698651;42940.570594294906;43647;44062.11875762531;41694.16611667689;41839.7908010458;42296.1540769189;42519.5748042528;43551.564484356015;34848.128796780285;35779.821100894325;35828.64171358253;35829.28341433209;36004.819975899954;36251;37182.8140859294;37922.2415551693;38309.4253586202;38539.2292154161;28581.571276431285;29165.85417072901;35444;35510.644893550736;35761.51003695238 05:08:37 INFO - PROCESS | 24656 | |2;jquery.html;388.7162371468826;389.4236529935696;396.70247314514097;404.93723472861706;411.5349654889974;13800.585982420544;16466.83533164668;18243.72634410483;19837.40487785367;19905.30331438402;17893.463196104105;17975.820241797577;18864.528386790338;18955.810441895577;19292.807071929277;5333.226682131089;5407;5829.533637309027;5855.560832937525;5892.587518873681;3961.4850069490926;5733.197352370671;5797;5857.355690874;5894.233749612545;6031.065184896326;6124.877502449948;6136.877262454748;6144.2319710036245;6145.047517634752;5529.585281103933;5825;5835.824925252249;6086.300075491309;6093.969530152343;5707.1153971134545;5728.598998070137;5739.16782066598;5741.856453588652;5771.682557459338;19395.515112122168;23396.883015584983;23604.763952360427;23731.406714832094;24174.274771756875;2573.4724381501746;2676.197140857754;2720.5239083160563;2723.978508059478;3108.3161704424992;10392.896071039268;10420.79158416835;10921.726956826064;11550.711232219177;15185.772213416807;1927.363969889947;1956.735840661521;1961.1370996761523;1978.0801927103967;1996.2214736252872;72140.63929680371;82961.58519207366;83121;84104.57947710283;85131.14868851294;11084.445777711082;11187.832182517268;11230.494627741771;11319.207655464039;11495.367754773568;13576.524821631196;14362.210078445576;15720.449784257497;15769.29038193284;15803.36786528526;7288.198298187195;7597.278258565428;8279.254867061993;8452.028016778026;8684.6526138955;8199;8237.299829514439;8261.917380826235;8332.62503187358;8390.37072219586;4755.358026666425;4832.9275060874115;4869.780859861244;4956.876078098005;4987.800487980513;1974.575466274758;2029.411470673488;2033.4342556231913;2036.1549956767776;2082.063071617778;931.4550987672152;948.2603569216022;977.3695966101825;1015.0610685116238;1043.4313299251926;20049.59900801976;20108.798912010694;20129.899350503445;20209.595808083755;20209.59580808405;985.3742873275521;994.9054839790208;1021.7394564386034;1033.4471057983942;1065.9147268218524;10890.29213101146;11091.611793587186;11171.94414027941;11246.943765281121;11251.887481125248;485557;491852.162956746;496377;503359;506257;54794.17808732872;56828.71585642045;63576.68211658912;81830;90530.09469905349;1008.863803386548;1046.7958748044211;1069.0645685025602;1071.4267866691282;1073.457903758597;17511.124443778015;17616.207270672596;17941.551461213574;17969.460916172535;18161.00114493663;41890.37164442475;41946.790266048476;42809.357859631506;42930;43417.34873976956;58358.124628129764;58748.706256468446;58785;58872.705636471546;59283;5307.283516725192;5315.9468405317;8774.517401542977;9018;9060.90939090627;12810;13777.724445511234;13865.09876858001;13930.512432064828;14090.436382544993;11492.655220343404;11871.584494542649;12093.637190884288;12115;12169.695757605776;11620.302781833117;11679.124065694938;11698.824517632072;11710.297382157098;11905;11929.701757456132;12111.878881211074;12126.090543209471;12297.877021229673;12357.505699772268;9044.14080662336;9067.455952642862;9093.318001150072;9122.270218382646;9278.283517549275;10598.417087060287;12135.696607584881;12292.692682683004;12429.564965226535;12493.812592810933 05:08:37 INFO - PROCESS | 24656 | |3;mootools.html;1297.682067893365;1456.927153642318;1481.9259037048148;1611.7098922194;1776.1652023548927;8186.54973976431;8696.04343522212;8715.172058654434;8924.062973387798;8925.419847709894;8712.390132690714;8889.28885689145;8916.821663566725;8918;8934.59794309256;1968.9606207875834;2045.539753555453;2233.2853486884205;2245.8764767937796;2282.6804247405375;2300.919467818627;2308.7114110736156;2310.560993411255;2310.780475854791;2311.9422014449688;2288.702468679078;2302.3898666853215;2317.617593097137;2317.8261630377706;2319.8840057997118;1907.3705677126584;2121.2151503943487;2181.1166477576608;2205.59196548639;2231.0852550454315;2205.4892398706775;2207.6136676081624;2233.586786444513;2235.273536100774;2236.7539570647214;8586.742397728078;8636.17956294151;8682.739517814476;8692.13078692132;8712.738617841474;4787.066522028206;4838.927416088762;4844.176489996709;4849.127157111719;4850.296706977504;3168.413843438971;3269.362474317509;3322.5846769153854;3324.850381732828;3366.8989930301886;1042.5360714481983;1076.0960792933895;1089.3681664634494;1105.4196546812907;1121.3664279681955;11041.558337666484;11061.059809916167;11066.336019838755;11173.050290725218;11277;4352.651787856964;4444.377787109743;4544.795484203219;4545.2954792007295;4565.109803588269;9815.165710914509;9819.705408837746;9823.754406139904;9844.704658860246;9867.358621689711;4905.3132561441425;5046.318746969112;5047.772850221749;5057.924131138036;5058.974705126451;4293.463317085364;4695.3426520287185;4864.489228631013;4871.951280487221;4922.704637721677;3871.825767840454;3906.648401643809;3957.6635985941516;3989.8628890765995;4028.67770578353;1199.3163896578867;1204.8493938257718;1206.4148887789415;1214.3078445286278;1221.7006833325893;997.2919227348664;1005.4168582222294;1022.0648106982028;1027.8561001459802;1032.0969151992008;6169.784057557964;6294.748210071546;6539.5422320438065;6564.80305590833;6599.571027883172;942.7454587261539;943.688582767685;945.479986007693;967.8983706710694;988.2143695761887;4370.6066454018655;4419.64642828573;4478.283474644041;4491.955080449219;4519.570640789119;10782.353058816496;10991.61529346469;11083.612073577548;11158.274712143684;11195.776084478428;10934.398608076632;10947.726306842233;10963.616273430393;11011.119110471303;11023.118150548098;7465.813354666068;7809.648565814552;7820.335271501872;8177.386695997824;8367.832643347221;6003.699815009145;6197.380261973766;6313.2424109107205;6420.1974753155855;6441.452476539546;9970.102690757867;10075.546600402853;10349;10372;10383.428911409643;10130.240231982483;10416.270861039655;10474.68575942723;10622.628208012682;10623.681289561326;7497.887531687138;7595.924040759522;8524.232819046316;8564.700235491728;8742.650293988168;8779.692710755093;8806.471611703062;8844.55777211124;8845.69040083594;8869.955650221966;7677.961610191914;7773.92226077732;7884.460979149462;7912.643931023003;8086.83826323482;7546.2831031051965;7749.380049596131;7765.72819951299;7845.3723702104835;7986.7603971880935;7067.5052746307265;7069.222385537484;7144.1784194818265;7162.283771623004;7164.140303163654;5157.149070403341;5239.502247286654;5251.52736253739;5268.2624432578705;5329.280547126088;4992.574712301253;5019.824306149268;5092.949070509248;5099.056674515226;5134.922976155435 05:08:37 INFO - PROCESS | 24656 | |4;prototype.html;327.3479998074423;337.4044810908746;343.6975461593797;344.42137209488067;344.9085992212064;5195.350581177353;5200.20592895451;5226.712530810809;5255.474452554752;5296.3379577552805;5178.689278643284;5186.977078939217;5228.9280697457025;5232.502912223342;5282.656627319221;4039.1719697462095;4099.651529619986;4100.958990410102;4134.586541345871;4140.254754144253;3810.341933509087;3881.981369687761;4027.5166979962446;4078.225137223918;4082.5509193988637;4037.7173597848164;4041.7777022263763;4061.3095773718537;4070.124923141524;4074.7555146691143;4030.2141082488924;4054.3107671695734;4098.405731168994;4105;4119.320312148492;3455.671711187433;3545.1314427965312;3632.128289210597;3672.4124140137715;3693.4829123922673;5084.593232541388;5101.591872650179;5106.514881086291;5106.744662766884;5116.539511443951;4690.835820746258;4722.512408591317;4744.739039352834;4757.643176761722;4778.784954677048;5331.693735034903;5412.188171774265;5443.755031023614;5468.699221542814;5479.424660410639;4044.312466880637;4051.6556092732153;4065.451164092839;4073.348264277701;4077.1641813428178;5436.673799572039;5583.134614134775;5740.54075673945;5744.425557444264;5747.425257474261;3758.342290099222;4103.138340948374;4120.1553681495225;4125.5874412558505;4148.481439820022;4169.228692691801;4170.47869016373;4172.374143878443;4189.49726032878;4194.559571244975;4512.593866552026;4733.857984260478;4733.976330118397;4744.146053710297;4759.643026773006;5421.536185230045;5435.972820135874;5439.809606663748;5446.291982042389;5448.610604295879;1406.1914399220489;1429.3639330497829;1430.29915341484;1450.3038541500139;1450.9915608651886;926.8321914387919;941.8257622339889;956.7703751099685;958.6626655815238;962.8301613539583;4726.314684370747;4738.360321356642;4741.644376671695;4748.857534273978;4751.311059896296;4946.282788995647;4970.701757894538;4987.925181122286;4990.625703072212;5002.624803139779;4731.077439899186;4741.2176990796825;4795.568398844051;4815.542523460265;4923.852284431473;2932.442835861222;2933.4426458972725;2963.5406511990677;2969.287371030937;2976.288634035395;5744.4829965303325;5772;5776.249087618583;5783.797567085132;5832.679202643895;5598.4961353477565;5716.399778023331;5724.771009159587;5769.221155144001;5779.219805326311;5729.942700573024;5807.622504537191;5810.564207684356;5842.883142337129;5844.298684157843;5414.485623865727;5652.802151924663;5658.603897727119;5679.9432005681065;5684.403137670485;5635.309407177912;5646.887062258814;5666.575006874584;5667.943320566742;5668.178114173339;5653.85865353353;5716.228309178374;5836.883262334644;5909.468147866713;5951.642901425928;4186.392973018956;4190.748555086705;4208.558101399309;4235.152969406069;4242.745435273893;5589.594114964389;5657.688827114548;5673.602847800615;5685.175649530877;5694.373618901835;5340.012097761926;5467.753951072291;5474.698891561003;5498.395176530498;5533.142362933751;5447.972760136174;5463.972680136574;5487.835364939058;5489.505944465017;5500.762328476221;5176.861090560071;5404.32445944257;5407.459254074561;5416.702081385404;5421.484958928895;5446.782128714807;5481.890362192814;5493.340799104133;5495.450454954473;5519.530839878656;5403.756830942696;5409.188621706776;5416.83749487516;5426.8371948841595;5428.945710542844 05:08:37 INFO - PROCESS | 24656 | |5;yui.html;709.4962576570634;725.8439435521362;773.3735674103976;787.8621241282776;798.2057852436824;14530.05554638949;14799;14946;15537.689246215068;15563.144027078535;13929;14550.417983280682;14598.854011459909;14694.926525367386;14707.338169782359;667.5293917787972;784.5136015670264;805.2149154574302;806.4596720197452;811.1888111888112;787.5353541410567;796.3350602247102;796.7928338631939;797.027626295921;797.3461761355661;847.5719761520423;848.0967769325679;849.3035710717214;849.3672214200429;849.4987957105307;693.5214701855729;824.1634740738156;844.0082902589432;844.4426678392263;845.2266176448542;614.2352770800337;614.2720875762236;614.5575185866169;615.0865964043392;615.9045347971072;13863.930680346635;13900.096493727875;13922.09506382082;13932.93033534836;13938.512152074629;13297.933510332387;13557.118787278796;13846.10000349974;14062.648433789134;14120.223387713671;12508.562200322946;12599.181053231603;12707.491700331975;12746.36268186587;12772.808407873796;4371.453568303962;4462.174497717932;4479.552044795527;4566.885827854297;4580.450345958473;70146.298537015;70489;70595.64702176508;70992.93510597397;71394;10703.678889633324;10927.890721092846;10979;11036.558537658564;11201.103911687209;19593.706094408597;19779.802201978084;19789.30737424183;19795;20209.39371818848;8056.5971701415865;8335.374846886387;8353;8365.623546940402;8396.832063358699;4507.188706032945;4548.545145485425;4643.233866412072;4690.273007683814;4831.178699621002;3256.365008823304;3353.3963886500665;3355.681210285019;3362.277110421271;3364.0748794081824;574.1986173771668;586.5571493522449;593.5044238061181;603.5021107586259;608.4767100293744;557.7545879812869;584.2142318581501;668.812732434919;676.1615596660205;705.9717611295594;8856.158664926821;8933.687320943865;8934.687285944961;8965.551722413853;9250.86123708145;562.9211910332557;610.517691024086;619.5260625621403;621.7481919822479;629.1537881549309;4291.420658211164;4340.587644173798;4368.492869959859;4414.6247568957;4485.85471766698;102159.48920255351;106228;106728;107867;109399.45300273447;58110;80093;92332.53833730923;93330.53334733284;93639.53180234056;78959;79223;80154.19845801467;80399;82172.9999999988;8416.158384161536;8560.229579337889;8579.571021449028;8672.176143266379;8888.511131887808;50298.976081914094;50594.73513162053;50892;51190.74404627953;52315;71125.28874711186;73252.26747732454;73756.10828528299;74327.62836185785;74553.25446745464;11887.16789824704;11965.401729913296;12026;12177.817332740193;12464.875351246372;12379.133460657667;12404.751904962031;12483.750324993267;12793.744125117259;13110.934445327712;11413.429328533373;11472.311661300015;11514.481848316678;11831.467583958914;11952;11578.536858525564;11798.823017654571;11869.643910682693;11985.880141198477;12262.938685306517;11080.667579972614;11514.94242528782;11573.363465009505;11737.589184378507;11831.467583958914;9661.613535458502;9667.419954802734;9853.605855765689;9872.802543949225;10002.499875006075;8937.642494300155;9266.397684150508;9328.766780830534;9675.758106047406;10064.245181611555 05:08:37 INFO - PROCESS | 24656 | __end_tp_report 05:08:37 INFO - PROCESS | 24656 | __start_cc_report 05:08:37 INFO - PROCESS | 24656 | _x_x_mozilla_cycle_collect,1116 05:08:37 INFO - PROCESS | 24656 | __end_cc_report 05:08:37 INFO - PROCESS | 24656 | __startTimestamp1467115717951__endTimestamp 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | ------- Summary: start ------- 05:08:37 INFO - PROCESS | 24656 | Number of tests: 6 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | [#0] dojo.html Cycles:165 Average:5224.35 Median:5394.27 stddev:599.61 (11.1%) stddev-sans-first:577.68 05:08:37 INFO - PROCESS | 24656 | Values: 3093.6 3106.0 3122.3 3143.4 3169.9 5188.5 5278.3 5297.7 5379.0 5389.1 5208.8 5218.0 5289.9 5319.7 5337.7 4689.9 4729.8 4752.1 4764.5 4902.3 4837.8 4854.0 4860.2 4861.5 4871.1 4628.5 4672.2 4678.0 4802.5 4833.7 4629.3 4634.5 4689.6 4738.7 4755.2 4606.1 4607.8 4629.2 4687.0 4724.5 5139.9 5199.7 5209.9 5223.6 5226.0 5572.3 5610.0 5624.3 5651.2 5704.1 5696.2 5728.1 5737.3 5750.2 5757.1 5168.6 5317.2 5318.2 5362.0 5365.4 5809.0 5875.1 5882.5 5933.3 5933.5 5610.5 5616.2 5621.8 5666.5 5673.5 5526.2 5536.5 5744.1 5757.7 5768.0 5536.4 5560.2 5562.1 5612.2 5612.9 5549.1 5584.1 5604.1 5604.6 5605.9 4226.3 4277.7 4277.8 4314.7 4345.9 3865.1 3880.7 3885.0 3918.0 3934.9 5361.3 5383.0 5386.1 5394.3 5429.8 5519.1 5595.9 5669.3 5682.1 5722.6 5331.5 5347.7 5348.2 5355.6 5386.6 4581.6 4590.1 4595.3 4598.0 4626.5 5654.9 5741.3 5795.7 5804.7 5837.1 5578.6 5610.9 5621.2 5621.4 5626.6 5789.9 5805.6 5837.4 5839.2 5844.8 5429.4 5538.6 5540.8 5558.3 5607.6 5642.8 5662.5 5675.8 5682.2 5687.0 5436.2 5527.4 5567.9 5570.6 5579.2 5352.2 5381.9 5396.5 5446.3 5470.6 5315.7 5351.4 5355.7 5356.9 5360.3 5459.4 5499.4 5519.0 5526.6 5539.6 5333.0 5382.9 5406.5 5407.4 5480.5 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | [#1] ext.html Cycles:180 Average:62444.95 Median:197172.50 stddev:126886.32 (64.4%) stddev-sans-first:127157.25 05:08:37 INFO - PROCESS | 24656 | Values: 579.2 606.1 618.6 627.0 631.3 30704.7 43719.6 44391.3 44475.0 44543.6 46395.8 46912.3 46932.5 46956.3 47004.5 8041.9 8362.3 8827.6 8984.2 10586.7 10298.6 10556.0 10728.4 10739.9 10746.2 10700.8 10759.2 10767.7 10812.1 10829.2 8211.5 10695.8 10984.1 10990.1 10991.9 10362.1 10436.1 10437.8 10833.0 10854.3 43133.4 43655.0 43681.6 43742.6 43769.0 3328.9 3451.9 3453.6 3470.9 3563.0 33753.2 34272.1 34509.3 34580.7 35373.1 4285.4 4290.1 4386.9 4475.0 4567.5 352947.0 354290.0 357881.0 358414.0 359832.2 35171.5 35516.8 35931.0 63825.4 65103.0 38365.8 38372.0 38507.6 38519.0 38528.8 14002.4 14968.4 15079.4 15084.8 15089.5 12541.5 12670.9 12692.2 13005.0 13029.4 8539.7 8619.5 8631.9 8670.4 8702.4 3347.4 3372.9 3377.6 3382.6 3415.4 1024.6 1041.1 1086.6 1131.8 1181.7 33136.3 33253.3 33786.0 33874.8 34295.7 1104.9 1118.8 1178.4 1195.9 1203.2 17561.8 17729.8 17730.6 17749.3 17865.3 568527.0 569598.0 570401.0 573253.0 574370.0 60439.1 60865.0 61058.4 61137.4 61147.7 1260.8 1345.7 1361.2 1364.8 1390.1 31014.8 34815.5 35048.1 35066.5 35419.3 52218.7 53049.2 53128.7 53190.7 53278.2 460842.0 483258.0 483377.0 484513.0 486570.0 38506.4 43505.3 43840.0 44995.3 47647.0 49998.3 50279.5 50450.7 50505.7 51248.0 41774.0 42465.2 42940.6 43647.0 44062.1 41694.2 41839.8 42296.2 42519.6 43551.6 34848.1 35779.8 35828.6 35829.3 36004.8 36251.0 37182.8 37922.2 38309.4 38539.2 28581.6 29165.9 35444.0 35510.6 35761.5 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | [#2] jquery.html Cycles:180 Average:28714.72 Median:2624.83 stddev:81503.41 (3105.1%) stddev-sans-first:81704.29 05:08:37 INFO - PROCESS | 24656 | Values: 388.7 389.4 396.7 404.9 411.5 13800.6 16466.8 18243.7 19837.4 19905.3 17893.5 17975.8 18864.5 18955.8 19292.8 5333.2 5407.0 5829.5 5855.6 5892.6 3961.5 5733.2 5797.0 5857.4 5894.2 6031.1 6124.9 6136.9 6144.2 6145.0 5529.6 5825.0 5835.8 6086.3 6094.0 5707.1 5728.6 5739.2 5741.9 5771.7 19395.5 23396.9 23604.8 23731.4 24174.3 2573.5 2676.2 2720.5 2724.0 3108.3 10392.9 10420.8 10921.7 11550.7 15185.8 1927.4 1956.7 1961.1 1978.1 1996.2 72140.6 82961.6 83121.0 84104.6 85131.1 11084.4 11187.8 11230.5 11319.2 11495.4 13576.5 14362.2 15720.4 15769.3 15803.4 7288.2 7597.3 8279.3 8452.0 8684.7 8199.0 8237.3 8261.9 8332.6 8390.4 4755.4 4832.9 4869.8 4956.9 4987.8 1974.6 2029.4 2033.4 2036.2 2082.1 931.5 948.3 977.4 1015.1 1043.4 20049.6 20108.8 20129.9 20209.6 20209.6 985.4 994.9 1021.7 1033.4 1065.9 10890.3 11091.6 11171.9 11246.9 11251.9 485557.0 491852.2 496377.0 503359.0 506257.0 54794.2 56828.7 63576.7 81830.0 90530.1 1008.9 1046.8 1069.1 1071.4 1073.5 17511.1 17616.2 17941.6 17969.5 18161.0 41890.4 41946.8 42809.4 42930.0 43417.3 58358.1 58748.7 58785.0 58872.7 59283.0 5307.3 5315.9 8774.5 9018.0 9060.9 12810.0 13777.7 13865.1 13930.5 14090.4 11492.7 11871.6 12093.6 12115.0 12169.7 11620.3 11679.1 11698.8 11710.3 11905.0 11929.7 12111.9 12126.1 12297.9 12357.5 9044.1 9067.5 9093.3 9122.3 9278.3 10598.4 12135.7 12292.7 12429.6 12493.8 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | [#3] mootools.html Cycles:180 Average:5786.61 Median:4813.00 stddev:3281.37 (68.2%) stddev-sans-first:3273.23 05:08:37 INFO - PROCESS | 24656 | Values: 1297.7 1456.9 1481.9 1611.7 1776.2 8186.5 8696.0 8715.2 8924.1 8925.4 8712.4 8889.3 8916.8 8918.0 8934.6 1969.0 2045.5 2233.3 2245.9 2282.7 2300.9 2308.7 2310.6 2310.8 2311.9 2288.7 2302.4 2317.6 2317.8 2319.9 1907.4 2121.2 2181.1 2205.6 2231.1 2205.5 2207.6 2233.6 2235.3 2236.8 8586.7 8636.2 8682.7 8692.1 8712.7 4787.1 4838.9 4844.2 4849.1 4850.3 3168.4 3269.4 3322.6 3324.9 3366.9 1042.5 1076.1 1089.4 1105.4 1121.4 11041.6 11061.1 11066.3 11173.1 11277.0 4352.7 4444.4 4544.8 4545.3 4565.1 9815.2 9819.7 9823.8 9844.7 9867.4 4905.3 5046.3 5047.8 5057.9 5059.0 4293.5 4695.3 4864.5 4872.0 4922.7 3871.8 3906.6 3957.7 3989.9 4028.7 1199.3 1204.8 1206.4 1214.3 1221.7 997.3 1005.4 1022.1 1027.9 1032.1 6169.8 6294.7 6539.5 6564.8 6599.6 942.7 943.7 945.5 967.9 988.2 4370.6 4419.6 4478.3 4492.0 4519.6 10782.4 10991.6 11083.6 11158.3 11195.8 10934.4 10947.7 10963.6 11011.1 11023.1 7465.8 7809.6 7820.3 8177.4 8367.8 6003.7 6197.4 6313.2 6420.2 6441.5 9970.1 10075.5 10349.0 10372.0 10383.4 10130.2 10416.3 10474.7 10622.6 10623.7 7497.9 7595.9 8524.2 8564.7 8742.7 8779.7 8806.5 8844.6 8845.7 8870.0 7678.0 7773.9 7884.5 7912.6 8086.8 7546.3 7749.4 7765.7 7845.4 7986.8 7067.5 7069.2 7144.2 7162.3 7164.1 5157.1 5239.5 5251.5 5268.3 5329.3 4992.6 5019.8 5092.9 5099.1 5134.9 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | [#4] prototype.html Cycles:180 Average:4591.68 Median:5177.78 stddev:1333.19 (25.7%) stddev-sans-first:1297.94 05:08:37 INFO - PROCESS | 24656 | Values: 327.3 337.4 343.7 344.4 344.9 5195.4 5200.2 5226.7 5255.5 5296.3 5178.7 5187.0 5228.9 5232.5 5282.7 4039.2 4099.7 4101.0 4134.6 4140.3 3810.3 3882.0 4027.5 4078.2 4082.6 4037.7 4041.8 4061.3 4070.1 4074.8 4030.2 4054.3 4098.4 4105.0 4119.3 3455.7 3545.1 3632.1 3672.4 3693.5 5084.6 5101.6 5106.5 5106.7 5116.5 4690.8 4722.5 4744.7 4757.6 4778.8 5331.7 5412.2 5443.8 5468.7 5479.4 4044.3 4051.7 4065.5 4073.3 4077.2 5436.7 5583.1 5740.5 5744.4 5747.4 3758.3 4103.1 4120.2 4125.6 4148.5 4169.2 4170.5 4172.4 4189.5 4194.6 4512.6 4733.9 4734.0 4744.1 4759.6 5421.5 5436.0 5439.8 5446.3 5448.6 1406.2 1429.4 1430.3 1450.3 1451.0 926.8 941.8 956.8 958.7 962.8 4726.3 4738.4 4741.6 4748.9 4751.3 4946.3 4970.7 4987.9 4990.6 5002.6 4731.1 4741.2 4795.6 4815.5 4923.9 2932.4 2933.4 2963.5 2969.3 2976.3 5744.5 5772.0 5776.2 5783.8 5832.7 5598.5 5716.4 5724.8 5769.2 5779.2 5729.9 5807.6 5810.6 5842.9 5844.3 5414.5 5652.8 5658.6 5679.9 5684.4 5635.3 5646.9 5666.6 5667.9 5668.2 5653.9 5716.2 5836.9 5909.5 5951.6 4186.4 4190.7 4208.6 4235.2 4242.7 5589.6 5657.7 5673.6 5685.2 5694.4 5340.0 5467.8 5474.7 5498.4 5533.1 5448.0 5464.0 5487.8 5489.5 5500.8 5176.9 5404.3 5407.5 5416.7 5421.5 5446.8 5481.9 5493.3 5495.5 5519.5 5403.8 5409.2 5416.8 5426.8 5428.9 05:08:37 INFO - PROCESS | 24656 | 05:08:37 INFO - PROCESS | 24656 | [#5] yui.html Cycles:180 Average:19288.14 Median:51752.87 stddev:27582.90 (53.3%) stddev-sans-first:27625.00 05:08:37 INFO - PROCESS | 24656 | Values: 709.5 725.8 773.4 787.9 798.2 14530.1 14799.0 14946.0 15537.7 15563.1 13929.0 14550.4 14598.9 14694.9 14707.3 667.5 784.5 805.2 806.5 811.2 787.5 796.3 796.8 797.0 797.3 847.6 848.1 849.3 849.4 849.5 693.5 824.2 844.0 844.4 845.2 614.2 614.3 614.6 615.1 615.9 13863.9 13900.1 13922.1 13932.9 13938.5 13297.9 13557.1 13846.1 14062.6 14120.2 12508.6 12599.2 12707.5 12746.4 12772.8 4371.5 4462.2 4479.6 4566.9 4580.5 70146.3 70489.0 70595.6 70992.9 71394.0 10703.7 10927.9 10979.0 11036.6 11201.1 19593.7 19779.8 19789.3 19795.0 20209.4 8056.6 8335.4 8353.0 8365.6 8396.8 4507.2 4548.5 4643.2 4690.3 4831.2 3256.4 3353.4 3355.7 3362.3 3364.1 574.2 586.6 593.5 603.5 608.5 557.8 584.2 668.8 676.2 706.0 8856.2 8933.7 8934.7 8965.6 9250.9 562.9 610.5 619.5 621.7 629.2 4291.4 4340.6 4368.5 4414.6 4485.9 102159.5 106228.0 106728.0 107867.0 109399.5 58110.0 80093.0 92332.5 93330.5 93639.5 78959.0 79223.0 80154.2 80399.0 82173.0 8416.2 8560.2 8579.6 8672.2 8888.5 50299.0 50594.7 50892.0 51190.7 52315.0 71125.3 73252.3 73756.1 74327.6 74553.3 11887.2 11965.4 12026.0 12177.8 12464.9 12379.1 12404.8 12483.8 12793.7 13110.9 11413.4 11472.3 11514.5 11831.5 11952.0 11578.5 11798.8 11869.6 11985.9 12262.9 11080.7 11514.9 11573.4 11737.6 11831.5 9661.6 9667.4 9853.6 9872.8 10002.5 8937.6 9266.4 9328.8 9675.8 10064.2 05:08:37 INFO - PROCESS | 24656 | -------- Summary: end -------- 05:08:37 INFO - PROCESS | 24656 | 05:08:38 INFO - TEST-INFO | 24656: exit 0 05:08:38 INFO - TEST-OK | dromaeo_css | took 1114727ms 05:08:38 INFO - TEST-START | kraken 05:08:38 INFO - operating with platform_type : linux_ 05:08:38 INFO - Initialising browser for kraken test... 05:08:38 INFO - TEST-INFO | started process 24838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPhpES/profile http://localhost:46488/getInfo.html) 05:08:42 INFO - PROCESS | 24838 | __metrics Screen width/height:1600/1200 05:08:42 INFO - PROCESS | 24838 | colorDepth:24 05:08:42 INFO - PROCESS | 24838 | Browser inner width/height: 1024/697 05:08:42 INFO - PROCESS | 24838 | __metrics 05:08:43 INFO - PROCESS | 24838 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:08:44 INFO - PROCESS | 24838 | console.error: PushService: 05:08:44 INFO - PROCESS | 24838 | stateChangeProcessEnqueue: Error transitioning state 05:08:44 INFO - PROCESS | 24838 | UnknownError 05:08:44 INFO - TEST-INFO | 24838: exit 0 05:08:44 INFO - Browser initialized. 05:08:44 INFO - Running cycle 1/1 for kraken test... 05:08:44 INFO - TEST-INFO | started process 24920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprPhpES/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:56 INFO - PROCESS | 24920 | RSS: Main: 173907968 05:08:56 INFO - PROCESS | 24920 | 05:08:59 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46488/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:00 INFO - PROCESS | 24920 | RSS: Main: 232501248 05:09:00 INFO - PROCESS | 24920 | 05:09:02 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46488/tests/kraken/driver.html?testName=audio-dft) 05:09:03 INFO - PROCESS | 24920 | RSS: Main: 220745728 05:09:03 INFO - PROCESS | 24920 | 05:09:06 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46488/tests/kraken/driver.html?testName=audio-fft) 05:09:07 INFO - PROCESS | 24920 | RSS: Main: 285925376 05:09:07 INFO - PROCESS | 24920 | 05:09:09 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46488/tests/kraken/driver.html?testName=audio-oscillator) 05:09:09 INFO - PROCESS | 24920 | RSS: Main: 197189632 05:09:09 INFO - PROCESS | 24920 | 05:09:12 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:12 INFO - PROCESS | 24920 | RSS: Main: 201379840 05:09:12 INFO - PROCESS | 24920 | 05:09:15 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46488/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:16 INFO - PROCESS | 24920 | RSS: Main: 237461504 05:09:16 INFO - PROCESS | 24920 | 05:09:19 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46488/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:20 INFO - PROCESS | 24920 | RSS: Main: 238190592 05:09:20 INFO - PROCESS | 24920 | 05:09:23 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46488/tests/kraken/driver.html?testName=json-parse-financial) 05:09:23 INFO - PROCESS | 24920 | RSS: Main: 238088192 05:09:23 INFO - PROCESS | 24920 | 05:09:25 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:25 INFO - PROCESS | 24920 | RSS: Main: 225787904 05:09:25 INFO - PROCESS | 24920 | 05:09:27 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:28 INFO - PROCESS | 24920 | RSS: Main: 228454400 05:09:28 INFO - PROCESS | 24920 | 05:09:30 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:09:30 INFO - PROCESS | 24920 | RSS: Main: 236118016 05:09:30 INFO - PROCESS | 24920 | 05:09:33 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:09:34 INFO - PROCESS | 24920 | RSS: Main: 237355008 05:09:34 INFO - PROCESS | 24920 | 05:09:36 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:09:37 INFO - PROCESS | 24920 | RSS: Main: 238940160 05:09:37 INFO - PROCESS | 24920 | 05:09:38 INFO - PROCESS | 24920 | Cycle 1(1): loaded http://localhost:46488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46488/tests/kraken/driver.html?testName=ai-astar) 05:09:39 INFO - PROCESS | 24920 | RSS: Main: 281509888 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | __start_tp_report 05:09:39 INFO - PROCESS | 24920 | _x_x_mozilla_page_load 05:09:39 INFO - PROCESS | 24920 | _x_x_mozilla_page_load_details 05:09:39 INFO - PROCESS | 24920 | |i|pagename|runs| 05:09:39 INFO - PROCESS | 24920 | |0;ai-astar;100;111;109;110;112;108;109;109;108;108 05:09:39 INFO - PROCESS | 24920 | |1;audio-beat-detection;157;125;127;187;126;127;155;127;161;126 05:09:39 INFO - PROCESS | 24920 | |2;audio-dft;162;159;162;161;160;162;162;160;160;160 05:09:39 INFO - PROCESS | 24920 | |3;audio-fft;75;74;76;123;75;75;73;74;99;75 05:09:39 INFO - PROCESS | 24920 | |4;audio-oscillator;84;85;111;86;86;86;122;86;86;121 05:09:39 INFO - PROCESS | 24920 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 05:09:39 INFO - PROCESS | 24920 | |6;imaging-darkroom;146;146;147;146;146;145;146;145;146;147 05:09:39 INFO - PROCESS | 24920 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 05:09:39 INFO - PROCESS | 24920 | |8;json-parse-financial;55;56;55;54;53;54;55;62;53;54 05:09:39 INFO - PROCESS | 24920 | |9;json-stringify-tinderbox;61;60;61;61;61;61;61;62;61;62 05:09:39 INFO - PROCESS | 24920 | |10;stanford-crypto-aes;78;83;79;79;85;86;80;87;90;80 05:09:39 INFO - PROCESS | 24920 | |11;stanford-crypto-ccm;122;128;127;128;120;119;124;122;131;126 05:09:39 INFO - PROCESS | 24920 | |12;stanford-crypto-pbkdf2;161;161;155;157;158;157;156;162;157;158 05:09:39 INFO - PROCESS | 24920 | |13;stanford-crypto-sha256-iterative;63;62;64;62;62;77;62;64;63;62 05:09:39 INFO - PROCESS | 24920 | __end_tp_report 05:09:39 INFO - PROCESS | 24920 | __start_cc_report 05:09:39 INFO - PROCESS | 24920 | _x_x_mozilla_cycle_collect,1604 05:09:39 INFO - PROCESS | 24920 | __end_cc_report 05:09:39 INFO - PROCESS | 24920 | __startTimestamp1467115779237__endTimestamp 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | ------- Summary: start ------- 05:09:39 INFO - PROCESS | 24920 | Number of tests: 14 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#0] ai-astar Cycles:10 Average:108.40 Median:109.00 stddev:3.24 (3.0%) stddev-sans-first:1.41 05:09:39 INFO - PROCESS | 24920 | Values: 100.0 111.0 109.0 110.0 112.0 108.0 109.0 109.0 108.0 108.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:141.00 stddev:21.74 (15.4%) stddev-sans-first:22.36 05:09:39 INFO - PROCESS | 24920 | Values: 157.0 125.0 127.0 187.0 126.0 127.0 155.0 127.0 161.0 126.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.50 stddev:1.14 (0.7%) stddev-sans-first:1.12 05:09:39 INFO - PROCESS | 24920 | Values: 162.0 159.0 162.0 161.0 160.0 162.0 162.0 160.0 160.0 160.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#3] audio-fft Cycles:10 Average:81.90 Median:75.00 stddev:16.37 (21.8%) stddev-sans-first:17.17 05:09:39 INFO - PROCESS | 24920 | Values: 75.0 74.0 76.0 123.0 75.0 75.0 73.0 74.0 99.0 75.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:86.00 stddev:15.94 (18.5%) stddev-sans-first:16.37 05:09:39 INFO - PROCESS | 24920 | Values: 84.0 85.0 111.0 86.0 86.0 86.0 122.0 86.0 86.0 121.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:09:39 INFO - PROCESS | 24920 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 05:09:39 INFO - PROCESS | 24920 | Values: 146.0 146.0 147.0 146.0 146.0 145.0 146.0 145.0 146.0 147.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:09:39 INFO - PROCESS | 24920 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:2.60 (4.7%) stddev-sans-first:2.76 05:09:39 INFO - PROCESS | 24920 | Values: 55.0 56.0 55.0 54.0 53.0 54.0 55.0 62.0 53.0 54.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 05:09:39 INFO - PROCESS | 24920 | Values: 61.0 60.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 62.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:84.00 stddev:4.11 (4.9%) stddev-sans-first:3.99 05:09:39 INFO - PROCESS | 24920 | Values: 78.0 83.0 79.0 79.0 85.0 86.0 80.0 87.0 90.0 80.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.50 stddev:3.92 (3.1%) stddev-sans-first:4.03 05:09:39 INFO - PROCESS | 24920 | Values: 122.0 128.0 127.0 128.0 120.0 119.0 124.0 122.0 131.0 126.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.00 stddev:2.35 (1.5%) stddev-sans-first:2.26 05:09:39 INFO - PROCESS | 24920 | Values: 161.0 161.0 155.0 157.0 158.0 157.0 156.0 162.0 157.0 158.0 05:09:39 INFO - PROCESS | 24920 | 05:09:39 INFO - PROCESS | 24920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:63.00 stddev:4.61 (7.3%) stddev-sans-first:4.87 05:09:39 INFO - PROCESS | 24920 | Values: 63.0 62.0 64.0 62.0 62.0 77.0 62.0 64.0 63.0 62.0 05:09:39 INFO - PROCESS | 24920 | -------- Summary: end -------- 05:09:39 INFO - PROCESS | 24920 | 05:09:40 INFO - TEST-INFO | 24920: exit 0 05:09:40 INFO - TEST-OK | kraken | took 61525ms 05:09:40 INFO - SUITE-END | took 1176s 05:09:40 INFO - Completed test suite (00:19:36) 05:09:40 INFO - javascript benchmark 05:09:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.5514350419185, 3105.95341069884, 3122.328699329644, 3143.4498962681555, 3169.857356418961, 5188.48115188481, 5278.261043453919, 5297.655652382592, 5378.951104534617, 5389.137737961922, 5208.817691380802, 5217.973910130453, 5289.8942021159555, 5319.654222475537, 5337.67973921564, 4689.859304220862, 4729.7635118244125, 4752.144613969484, 4764.523547645225, 4902.289168070628, 4837.7822997965, 4853.951460485403, 4860.222364421693, 4861.538153875376, 4871.098846713369, 4628.490866004737, 4672.2057250267535, 4678.017616300581, 4802.543758342952, 4833.685810422311, 4629.259318509056, 4634.513376095529, 4689.62483001359, 4738.715677059353, 4755.239161734106, 4606.147862645421, 4607.769611519444, 4629.189891768927, 4687.015726697397, 4724.45668748095, 5139.948600514022, 5199.714015729133, 5209.921851172236, 5223.6343455958095, 5226.0, 5572.275604171472, 5610.046292130348, 5624.3250809902665, 5651.1523271509195, 5704.087346024616, 5696.189926108863, 5728.054870946289, 5737.254156959611, 5750.223719797816, 5757.136429535603, 5168.586513078944, 5317.229001794795, 5318.202269659543, 5362.034833729927, 5365.356157261153, 5809.041508151107, 5875.059990401601, 5882.470577647947, 5933.258342707161, 5933.495652869555, 5610.4670056344585, 5616.185653080281, 5621.80323688669, 5666.546676265889, 5673.546116310686, 5526.171074338801, 5536.501714845684, 5744.080947048452, 5757.712114394263, 5767.971160144256, 5536.390996990328, 5560.221568980346, 5562.054450743383, 5612.186232996192, 5612.887742245132, 5549.084401073858, 5584.106542953108, 5604.131359639263, 5604.635698679573, 5605.887882242332, 4226.344916537942, 4277.743335399886, 4277.786110694453, 4314.654827613784, 4345.891352716144, 3865.1110244643887, 3880.708946828999, 3885.0287428142965, 3917.9804100979313, 3934.940975885364, 5361.303030605996, 5383.031054410244, 5386.084365657847, 5394.271773310553, 5429.755660995264, 5519.116941289374, 5595.916061259084, 5669.31968163823, 5682.090865461506, 5722.570807189478, 5331.5201631853315, 5347.652402593819, 5348.171033489815, 5355.598330125256, 5386.649867758583, 4581.587657110876, 4590.059037897223, 4595.264757638762, 4597.977010114995, 4626.4910859805395, 5654.943450565442, 5741.282339707536, 5795.681237531976, 5804.680742559115, 5837.066069428871, 5578.63738856973, 5610.859728506657, 5621.241132447068, 5621.353544342453, 5626.634268772516, 5789.884202315846, 5805.622634528742, 5837.416258374129, 5839.211706419749, 5844.795432159854, 5429.40276569585, 5538.6399884007415, 5540.833774986757, 5558.277423934863, 5607.635503692247, 5642.774289028557, 5662.546996240373, 5675.801346952837, 5682.232898558642, 5686.9715651421475, 5436.184572314184, 5527.39198688152, 5567.8886422272135, 5570.58220633446, 5579.246801681883, 5352.1971704243115, 5381.946180538144, 5396.514313711785, 5446.319210098738, 5470.589705772003, 5315.681059136464, 5351.438098999549, 5355.705436201047, 5356.866078348073, 5360.3299587551555, 5459.39946605881, 5499.4225606310765, 5519.034169020325, 5526.55787536988, 5539.612227144061, 5333.0, 5382.865428364322, 5406.459354064562, 5407.351117865881, 5480.451954804487], "value": 5184.313009037869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.1862433281241, 606.0938896349957, 618.5515501261583, 626.9592476489031, 631.2614241337636, 30704.692953070462, 43719.56280437195, 44391.334129988, 44475.0, 44543.55456445439, 46395.76802115993, 46912.29631555529, 46932.53067469324, 46956.29565556519, 47004.52995470044, 8041.919580804205, 8362.331013518904, 8827.602757875895, 8984.19142277195, 10586.735331616732, 10298.639547615834, 10556.049955504002, 10728.409937453436, 10739.892601074007, 10746.247762656618, 10700.839487407657, 10759.193060520452, 10767.676969690921, 10812.080973117294, 10829.187810914174, 8211.548364839931, 10695.786084278348, 10984.06635435989, 10990.065844403236, 10991.945040274828, 10362.067413932707, 10436.112930400925, 10437.843432348522, 10833.0, 10854.348739075602, 43133.35299970503, 43655.0, 43681.56318436807, 43742.56257437417, 43769.0, 3328.9001329959897, 3451.930961380758, 3453.637368076366, 3470.8958731238104, 3563.0379797454543, 33753.156171095674, 34272.143196420286, 34509.30981380383, 34580.654193457995, 35373.11567210814, 4285.442892423996, 4290.077633308822, 4386.934195987031, 4474.955250447519, 4567.520410356898, 352947.0, 354290.0, 357881.0, 358414.0, 359832.20083899674, 35171.47242791309, 35516.82241588776, 35931.0, 63825.36174638287, 65103.0, 38365.80817095897, 38372.0, 38507.6149238504, 38519.0, 38528.80735596304, 14002.369893354824, 14968.428315026984, 15079.43649579574, 15084.849151508564, 15089.47186848455, 12541.498340066477, 12670.936645316899, 12692.238465692088, 13005.0, 13029.413676384585, 8539.74380768578, 8619.482831030158, 8631.913680863237, 8670.35263299971, 8702.39083264178, 3347.3640008398324, 3372.8819491317686, 3377.594688637379, 3382.5624109753257, 3415.4023045966856, 1024.6157690865925, 1041.0953439902737, 1086.6033897627467, 1131.7679875625477, 1181.71048093216, 33136.33727325488, 33253.3349333012, 33786.0, 33874.83062584721, 34295.657043429244, 1104.9392283424488, 1118.8042092633757, 1178.3813497913493, 1195.8505186851644, 1203.2479700187382, 17561.824381756018, 17729.822701772817, 17730.5567360817, 17749.29002839872, 17865.285388584573, 568527.0, 569598.0, 570401.0, 573253.0, 574370.0, 60439.09341359883, 60865.0, 61058.38941610527, 61137.38862611317, 61147.7196596234, 1260.7541529401863, 1345.7308538292184, 1361.224102261721, 1364.7611667958067, 1390.1450607876286, 31014.844925775225, 34815.47776783401, 35048.12379690528, 35066.474002890485, 35419.29161416809, 52218.738906305225, 53049.20426193533, 53128.734356329514, 53190.73404632952, 53278.2008269884, 460842.0, 483258.0, 483377.0, 484513.0, 486570.0, 38506.422403663404, 43505.34741978809, 43840.0, 44995.32507012463, 47647.0, 49998.250026248905, 50279.49720502748, 50450.74774626103, 50505.74747126388, 51248.0, 41774.0, 42465.15069698651, 42940.570594294906, 43647.0, 44062.11875762531, 41694.16611667689, 41839.7908010458, 42296.1540769189, 42519.5748042528, 43551.564484356015, 34848.128796780285, 35779.821100894325, 35828.64171358253, 35829.28341433209, 36004.819975899954, 36251.0, 37182.8140859294, 37922.2415551693, 38309.4253586202, 38539.2292154161, 28581.571276431285, 29165.85417072901, 35444.0, 35510.644893550736, 35761.51003695238], "value": 19927.982036892783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7162371468826, 389.4236529935696, 396.70247314514097, 404.93723472861706, 411.5349654889974, 13800.585982420544, 16466.83533164668, 18243.72634410483, 19837.40487785367, 19905.30331438402, 17893.463196104105, 17975.820241797577, 18864.528386790338, 18955.810441895577, 19292.807071929277, 5333.226682131089, 5407.0, 5829.533637309027, 5855.560832937525, 5892.587518873681, 3961.4850069490926, 5733.197352370671, 5797.0, 5857.355690874, 5894.233749612545, 6031.065184896326, 6124.877502449948, 6136.877262454748, 6144.2319710036245, 6145.047517634752, 5529.585281103933, 5825.0, 5835.824925252249, 6086.300075491309, 6093.969530152343, 5707.1153971134545, 5728.598998070137, 5739.16782066598, 5741.856453588652, 5771.682557459338, 19395.515112122168, 23396.883015584983, 23604.763952360427, 23731.406714832094, 24174.274771756875, 2573.4724381501746, 2676.197140857754, 2720.5239083160563, 2723.978508059478, 3108.3161704424992, 10392.896071039268, 10420.79158416835, 10921.726956826064, 11550.711232219177, 15185.772213416807, 1927.363969889947, 1956.735840661521, 1961.1370996761523, 1978.0801927103967, 1996.2214736252872, 72140.63929680371, 82961.58519207366, 83121.0, 84104.57947710283, 85131.14868851294, 11084.445777711082, 11187.832182517268, 11230.494627741771, 11319.207655464039, 11495.367754773568, 13576.524821631196, 14362.210078445576, 15720.449784257497, 15769.29038193284, 15803.36786528526, 7288.198298187195, 7597.278258565428, 8279.254867061993, 8452.028016778026, 8684.6526138955, 8199.0, 8237.299829514439, 8261.917380826235, 8332.62503187358, 8390.37072219586, 4755.358026666425, 4832.9275060874115, 4869.780859861244, 4956.876078098005, 4987.800487980513, 1974.575466274758, 2029.411470673488, 2033.4342556231913, 2036.1549956767776, 2082.063071617778, 931.4550987672152, 948.2603569216022, 977.3695966101825, 1015.0610685116238, 1043.4313299251926, 20049.59900801976, 20108.798912010694, 20129.899350503445, 20209.595808083755, 20209.59580808405, 985.3742873275521, 994.9054839790208, 1021.7394564386034, 1033.4471057983942, 1065.9147268218524, 10890.29213101146, 11091.611793587186, 11171.94414027941, 11246.943765281121, 11251.887481125248, 485557.0, 491852.162956746, 496377.0, 503359.0, 506257.0, 54794.17808732872, 56828.71585642045, 63576.68211658912, 81830.0, 90530.09469905349, 1008.863803386548, 1046.7958748044211, 1069.0645685025602, 1071.4267866691282, 1073.457903758597, 17511.124443778015, 17616.207270672596, 17941.551461213574, 17969.460916172535, 18161.00114493663, 41890.37164442475, 41946.790266048476, 42809.357859631506, 42930.0, 43417.34873976956, 58358.124628129764, 58748.706256468446, 58785.0, 58872.705636471546, 59283.0, 5307.283516725192, 5315.9468405317, 8774.517401542977, 9018.0, 9060.90939090627, 12810.0, 13777.724445511234, 13865.09876858001, 13930.512432064828, 14090.436382544993, 11492.655220343404, 11871.584494542649, 12093.637190884288, 12115.0, 12169.695757605776, 11620.302781833117, 11679.124065694938, 11698.824517632072, 11710.297382157098, 11905.0, 11929.701757456132, 12111.878881211074, 12126.090543209471, 12297.877021229673, 12357.505699772268, 9044.14080662336, 9067.455952642862, 9093.318001150072, 9122.270218382646, 9278.283517549275, 10598.417087060287, 12135.696607584881, 12292.692682683004, 12429.564965226535, 12493.812592810933], "value": 9314.241044340124, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1297.682067893365, 1456.927153642318, 1481.9259037048148, 1611.7098922194, 1776.1652023548927, 8186.54973976431, 8696.04343522212, 8715.172058654434, 8924.062973387798, 8925.419847709894, 8712.390132690714, 8889.28885689145, 8916.821663566725, 8918.0, 8934.59794309256, 1968.9606207875834, 2045.539753555453, 2233.2853486884205, 2245.8764767937796, 2282.6804247405375, 2300.919467818627, 2308.7114110736156, 2310.560993411255, 2310.780475854791, 2311.9422014449688, 2288.702468679078, 2302.3898666853215, 2317.617593097137, 2317.8261630377706, 2319.8840057997118, 1907.3705677126584, 2121.2151503943487, 2181.1166477576608, 2205.59196548639, 2231.0852550454315, 2205.4892398706775, 2207.6136676081624, 2233.586786444513, 2235.273536100774, 2236.7539570647214, 8586.742397728078, 8636.17956294151, 8682.739517814476, 8692.13078692132, 8712.738617841474, 4787.066522028206, 4838.927416088762, 4844.176489996709, 4849.127157111719, 4850.296706977504, 3168.413843438971, 3269.362474317509, 3322.5846769153854, 3324.850381732828, 3366.8989930301886, 1042.5360714481983, 1076.0960792933895, 1089.3681664634494, 1105.4196546812907, 1121.3664279681955, 11041.558337666484, 11061.059809916167, 11066.336019838755, 11173.050290725218, 11277.0, 4352.651787856964, 4444.377787109743, 4544.795484203219, 4545.2954792007295, 4565.109803588269, 9815.165710914509, 9819.705408837746, 9823.754406139904, 9844.704658860246, 9867.358621689711, 4905.3132561441425, 5046.318746969112, 5047.772850221749, 5057.924131138036, 5058.974705126451, 4293.463317085364, 4695.3426520287185, 4864.489228631013, 4871.951280487221, 4922.704637721677, 3871.825767840454, 3906.648401643809, 3957.6635985941516, 3989.8628890765995, 4028.67770578353, 1199.3163896578867, 1204.8493938257718, 1206.4148887789415, 1214.3078445286278, 1221.7006833325893, 997.2919227348664, 1005.4168582222294, 1022.0648106982028, 1027.8561001459802, 1032.0969151992008, 6169.784057557964, 6294.748210071546, 6539.5422320438065, 6564.80305590833, 6599.571027883172, 942.7454587261539, 943.688582767685, 945.479986007693, 967.8983706710694, 988.2143695761887, 4370.6066454018655, 4419.64642828573, 4478.283474644041, 4491.955080449219, 4519.570640789119, 10782.353058816496, 10991.61529346469, 11083.612073577548, 11158.274712143684, 11195.776084478428, 10934.398608076632, 10947.726306842233, 10963.616273430393, 11011.119110471303, 11023.118150548098, 7465.813354666068, 7809.648565814552, 7820.335271501872, 8177.386695997824, 8367.832643347221, 6003.699815009145, 6197.380261973766, 6313.2424109107205, 6420.1974753155855, 6441.452476539546, 9970.102690757867, 10075.546600402853, 10349.0, 10372.0, 10383.428911409643, 10130.240231982483, 10416.270861039655, 10474.68575942723, 10622.628208012682, 10623.681289561326, 7497.887531687138, 7595.924040759522, 8524.232819046316, 8564.700235491728, 8742.650293988168, 8779.692710755093, 8806.471611703062, 8844.55777211124, 8845.69040083594, 8869.955650221966, 7677.961610191914, 7773.92226077732, 7884.460979149462, 7912.643931023003, 8086.83826323482, 7546.2831031051965, 7749.380049596131, 7765.72819951299, 7845.3723702104835, 7986.7603971880935, 7067.5052746307265, 7069.222385537484, 7144.1784194818265, 7162.283771623004, 7164.140303163654, 5157.149070403341, 5239.502247286654, 5251.52736253739, 5268.2624432578705, 5329.280547126088, 4992.574712301253, 5019.824306149268, 5092.949070509248, 5099.056674515226, 5134.922976155435], "value": 4614.194435411617, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3479998074423, 337.4044810908746, 343.6975461593797, 344.42137209488067, 344.9085992212064, 5195.350581177353, 5200.20592895451, 5226.712530810809, 5255.474452554752, 5296.3379577552805, 5178.689278643284, 5186.977078939217, 5228.9280697457025, 5232.502912223342, 5282.656627319221, 4039.1719697462095, 4099.651529619986, 4100.958990410102, 4134.586541345871, 4140.254754144253, 3810.341933509087, 3881.981369687761, 4027.5166979962446, 4078.225137223918, 4082.5509193988637, 4037.7173597848164, 4041.7777022263763, 4061.3095773718537, 4070.124923141524, 4074.7555146691143, 4030.2141082488924, 4054.3107671695734, 4098.405731168994, 4105.0, 4119.320312148492, 3455.671711187433, 3545.1314427965312, 3632.128289210597, 3672.4124140137715, 3693.4829123922673, 5084.593232541388, 5101.591872650179, 5106.514881086291, 5106.744662766884, 5116.539511443951, 4690.835820746258, 4722.512408591317, 4744.739039352834, 4757.643176761722, 4778.784954677048, 5331.693735034903, 5412.188171774265, 5443.755031023614, 5468.699221542814, 5479.424660410639, 4044.312466880637, 4051.6556092732153, 4065.451164092839, 4073.348264277701, 4077.1641813428178, 5436.673799572039, 5583.134614134775, 5740.54075673945, 5744.425557444264, 5747.425257474261, 3758.342290099222, 4103.138340948374, 4120.1553681495225, 4125.5874412558505, 4148.481439820022, 4169.228692691801, 4170.47869016373, 4172.374143878443, 4189.49726032878, 4194.559571244975, 4512.593866552026, 4733.857984260478, 4733.976330118397, 4744.146053710297, 4759.643026773006, 5421.536185230045, 5435.972820135874, 5439.809606663748, 5446.291982042389, 5448.610604295879, 1406.1914399220489, 1429.3639330497829, 1430.29915341484, 1450.3038541500139, 1450.9915608651886, 926.8321914387919, 941.8257622339889, 956.7703751099685, 958.6626655815238, 962.8301613539583, 4726.314684370747, 4738.360321356642, 4741.644376671695, 4748.857534273978, 4751.311059896296, 4946.282788995647, 4970.701757894538, 4987.925181122286, 4990.625703072212, 5002.624803139779, 4731.077439899186, 4741.2176990796825, 4795.568398844051, 4815.542523460265, 4923.852284431473, 2932.442835861222, 2933.4426458972725, 2963.5406511990677, 2969.287371030937, 2976.288634035395, 5744.4829965303325, 5772.0, 5776.249087618583, 5783.797567085132, 5832.679202643895, 5598.4961353477565, 5716.399778023331, 5724.771009159587, 5769.221155144001, 5779.219805326311, 5729.942700573024, 5807.622504537191, 5810.564207684356, 5842.883142337129, 5844.298684157843, 5414.485623865727, 5652.802151924663, 5658.603897727119, 5679.9432005681065, 5684.403137670485, 5635.309407177912, 5646.887062258814, 5666.575006874584, 5667.943320566742, 5668.178114173339, 5653.85865353353, 5716.228309178374, 5836.883262334644, 5909.468147866713, 5951.642901425928, 4186.392973018956, 4190.748555086705, 4208.558101399309, 4235.152969406069, 4242.745435273893, 5589.594114964389, 5657.688827114548, 5673.602847800615, 5685.175649530877, 5694.373618901835, 5340.012097761926, 5467.753951072291, 5474.698891561003, 5498.395176530498, 5533.142362933751, 5447.972760136174, 5463.972680136574, 5487.835364939058, 5489.505944465017, 5500.762328476221, 5176.861090560071, 5404.32445944257, 5407.459254074561, 5416.702081385404, 5421.484958928895, 5446.782128714807, 5481.890362192814, 5493.340799104133, 5495.450454954473, 5519.530839878656, 5403.756830942696, 5409.188621706776, 5416.83749487516, 5426.8371948841595, 5428.945710542844], "value": 4173.10950378154, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.4962576570634, 725.8439435521362, 773.3735674103976, 787.8621241282776, 798.2057852436824, 14530.05554638949, 14799.0, 14946.0, 15537.689246215068, 15563.144027078535, 13929.0, 14550.417983280682, 14598.854011459909, 14694.926525367386, 14707.338169782359, 667.5293917787972, 784.5136015670264, 805.2149154574302, 806.4596720197452, 811.1888111888112, 787.5353541410567, 796.3350602247102, 796.7928338631939, 797.027626295921, 797.3461761355661, 847.5719761520423, 848.0967769325679, 849.3035710717214, 849.3672214200429, 849.4987957105307, 693.5214701855729, 824.1634740738156, 844.0082902589432, 844.4426678392263, 845.2266176448542, 614.2352770800337, 614.2720875762236, 614.5575185866169, 615.0865964043392, 615.9045347971072, 13863.930680346635, 13900.096493727875, 13922.09506382082, 13932.93033534836, 13938.512152074629, 13297.933510332387, 13557.118787278796, 13846.10000349974, 14062.648433789134, 14120.223387713671, 12508.562200322946, 12599.181053231603, 12707.491700331975, 12746.36268186587, 12772.808407873796, 4371.453568303962, 4462.174497717932, 4479.552044795527, 4566.885827854297, 4580.450345958473, 70146.298537015, 70489.0, 70595.64702176508, 70992.93510597397, 71394.0, 10703.678889633324, 10927.890721092846, 10979.0, 11036.558537658564, 11201.103911687209, 19593.706094408597, 19779.802201978084, 19789.30737424183, 19795.0, 20209.39371818848, 8056.5971701415865, 8335.374846886387, 8353.0, 8365.623546940402, 8396.832063358699, 4507.188706032945, 4548.545145485425, 4643.233866412072, 4690.273007683814, 4831.178699621002, 3256.365008823304, 3353.3963886500665, 3355.681210285019, 3362.277110421271, 3364.0748794081824, 574.1986173771668, 586.5571493522449, 593.5044238061181, 603.5021107586259, 608.4767100293744, 557.7545879812869, 584.2142318581501, 668.812732434919, 676.1615596660205, 705.9717611295594, 8856.158664926821, 8933.687320943865, 8934.687285944961, 8965.551722413853, 9250.86123708145, 562.9211910332557, 610.517691024086, 619.5260625621403, 621.7481919822479, 629.1537881549309, 4291.420658211164, 4340.587644173798, 4368.492869959859, 4414.6247568957, 4485.85471766698, 102159.48920255351, 106228.0, 106728.0, 107867.0, 109399.45300273447, 58110.0, 80093.0, 92332.53833730923, 93330.53334733284, 93639.53180234056, 78959.0, 79223.0, 80154.19845801467, 80399.0, 82172.9999999988, 8416.158384161536, 8560.229579337889, 8579.571021449028, 8672.176143266379, 8888.511131887808, 50298.976081914094, 50594.73513162053, 50892.0, 51190.74404627953, 52315.0, 71125.28874711186, 73252.26747732454, 73756.10828528299, 74327.62836185785, 74553.25446745464, 11887.16789824704, 11965.401729913296, 12026.0, 12177.817332740193, 12464.875351246372, 12379.133460657667, 12404.751904962031, 12483.750324993267, 12793.744125117259, 13110.934445327712, 11413.429328533373, 11472.311661300015, 11514.481848316678, 11831.467583958914, 11952.0, 11578.536858525564, 11798.823017654571, 11869.643910682693, 11985.880141198477, 12262.938685306517, 11080.667579972614, 11514.94242528782, 11573.363465009505, 11737.589184378507, 11831.467583958914, 9661.613535458502, 9667.419954802734, 9853.605855765689, 9872.802543949225, 10002.499875006075, 8937.642494300155, 9266.397684150508, 9328.766780830534, 9675.758106047406, 10064.245181611555], "value": 7102.431567187835, "unit": "score"}], "name": "dromaeo_css", "value": 7132.117401701485, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 109.0, 110.0, 112.0, 108.0, 109.0, 109.0, 108.0, 108.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 127.0, 187.0, 126.0, 127.0, 155.0, 127.0, 161.0, 126.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 159.0, 162.0, 161.0, 160.0, 162.0, 162.0, 160.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 123.0, 75.0, 75.0, 73.0, 74.0, 99.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 111.0, 86.0, 86.0, 86.0, 122.0, 86.0, 86.0, 121.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 147.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 53.0, 54.0, 55.0, 62.0, 53.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 79.0, 79.0, 85.0, 86.0, 80.0, 87.0, 90.0, 80.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 128.0, 127.0, 128.0, 120.0, 119.0, 124.0, 122.0, 131.0, 126.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 155.0, 157.0, 158.0, 157.0, 156.0, 162.0, 157.0, 158.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 62.0, 62.0, 77.0, 62.0, 64.0, 63.0, 62.0], "value": 64.1, "unit": "score"}], "name": "kraken", "value": 1492.2, "alertThreshold": 2.0}]} 05:09:40 INFO - Return code: 0 05:09:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:09:40 INFO - # TBPL SUCCESS # 05:09:40 INFO - Running post-action listener: _resource_record_post_action 05:09:40 INFO - ##### 05:09:40 INFO - ##### Finished run-tests step (success) 05:09:40 INFO - ##### 05:09:40 INFO - Running post-run listener: _resource_record_post_run 05:09:40 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 551739392; Read time: 0; Write time: 545224 05:09:40 INFO - TinderboxPrint: CPU usage
13.2% 05:09:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 05:09:40 INFO - TinderboxPrint: I/O write bytes / time
551,739,392 / 545,224 05:09:40 INFO - TinderboxPrint: CPU idle
8,278.7 (86.8%) 05:09:40 INFO - TinderboxPrint: CPU user
1,209.0 (12.7%) 05:09:40 INFO - TinderboxPrint: Swap in / out
0 / 0 05:09:40 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256856064; Read time: 0; Write time: 302464 05:09:40 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 294883328; Read time: 0; Write time: 242760 05:09:41 INFO - Running post-run listener: _upload_blobber_files 05:09:41 INFO - Blob upload gear active. 05:09:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:09:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:09:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:09:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:09:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:09:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:09:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:09:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:42 INFO - (blobuploader) - INFO - Done attempting. 05:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:45 INFO - (blobuploader) - INFO - Done attempting. 05:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:09:46 INFO - (blobuploader) - INFO - Done attempting. 05:09:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:09:46 INFO - Return code: 0 05:09:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:09:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:09:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/088911bbbaece53af9d478079bc6c5e1338f1773323bdab91070ac80274aad21a9bc4e25f366909ffd019fa7563ba1ccda7a42abc6af566c4fe2943f257106dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a03937038051571a570b9a415eaec88541f5e83ef3016840d292c4afb545bb9c2b8fe15403121718c82ddefeab5d6ae7df0d35ce1ed012f89a42f2f0ce48e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/570052269ba60111489bd31c1dca68589f88c45cbf88b5d03ef18720194fe5d8343b599f00aa130f2d8be940f56eeb26bd545eb2fc15883a6882e5abd2d1143d"} 05:09:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:09:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:09:46 INFO - Contents: 05:09:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/088911bbbaece53af9d478079bc6c5e1338f1773323bdab91070ac80274aad21a9bc4e25f366909ffd019fa7563ba1ccda7a42abc6af566c4fe2943f257106dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a03937038051571a570b9a415eaec88541f5e83ef3016840d292c4afb545bb9c2b8fe15403121718c82ddefeab5d6ae7df0d35ce1ed012f89a42f2f0ce48e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/570052269ba60111489bd31c1dca68589f88c45cbf88b5d03ef18720194fe5d8343b599f00aa130f2d8be940f56eeb26bd545eb2fc15883a6882e5abd2d1143d"} 05:09:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:09:46 INFO - Copying logs to upload dir... 05:09:46 INFO - mkdir: /builds/slave/test/build/upload/logs 05:09:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.667864 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-28 05:09:45.329911) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-06-28 05:09:45.334069) ========= 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=836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/088911bbbaece53af9d478079bc6c5e1338f1773323bdab91070ac80274aad21a9bc4e25f366909ffd019fa7563ba1ccda7a42abc6af566c4fe2943f257106dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a03937038051571a570b9a415eaec88541f5e83ef3016840d292c4afb545bb9c2b8fe15403121718c82ddefeab5d6ae7df0d35ce1ed012f89a42f2f0ce48e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/570052269ba60111489bd31c1dca68589f88c45cbf88b5d03ef18720194fe5d8343b599f00aa130f2d8be940f56eeb26bd545eb2fc15883a6882e5abd2d1143d"} build_url:https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/W4RBrTXWR0qJrCkoRm1kCQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/088911bbbaece53af9d478079bc6c5e1338f1773323bdab91070ac80274aad21a9bc4e25f366909ffd019fa7563ba1ccda7a42abc6af566c4fe2943f257106dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4a03937038051571a570b9a415eaec88541f5e83ef3016840d292c4afb545bb9c2b8fe15403121718c82ddefeab5d6ae7df0d35ce1ed012f89a42f2f0ce48e6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/570052269ba60111489bd31c1dca68589f88c45cbf88b5d03ef18720194fe5d8343b599f00aa130f2d8be940f56eeb26bd545eb2fc15883a6882e5abd2d1143d"}' ========= master_lag: 3.98 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-06-28 05:09:49.325912) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:09:49.326250) ========= 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=836cfdc75598d54cb747368e000001a9-1467114547.584520-23501246 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 05:09:49.557715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 05:09:49.558065) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 05:09:49.558389) ========= ========= Total master_lag: 4.29 =========