builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-063 starttime: 1466104345.75 results: success (0) buildid: 20160616093021 builduid: d2374eb4927444028ad6db6f7e1b8a8d revision: ea9d62d5f09b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.748117) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.748696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.749023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.787168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.787467) ========= 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=33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-16 12:12:26-- 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% 88.8M=0s 2016-06-16 12:12:26 (88.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.942848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.943176) ========= 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=33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016473 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.997718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:25.998074) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea9d62d5f09b --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 ea9d62d5f09b --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=33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-16 12:12:26,297 Setting DEBUG logging. 2016-06-16 12:12:26,297 attempt 1/10 2016-06-16 12:12:26,297 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea9d62d5f09b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-16 12:12:26,594 unpacking tar archive at: fx-team-ea9d62d5f09b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:26.636609) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:26.636931) ========= script_repo_revision: ea9d62d5f09b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:26.637369) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:26.637729) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-16 12:12:26.651530) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-06-16 12:12:26.651864) ========= /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=33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:12:27 INFO - MultiFileLogger online at 20160616 12:12:27 in /builds/slave/test 12:12:27 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 12:12:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:12:27 INFO - {'append_to_log': False, 12:12:27 INFO - 'base_work_dir': '/builds/slave/test', 12:12:27 INFO - 'blob_upload_branch': 'Fx-Team', 12:12:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:12:27 INFO - 'branch': 'Fx-Team', 12:12:27 INFO - 'buildbot_json_path': 'buildprops.json', 12:12:27 INFO - 'config_files': ('talos/linux_config.py',), 12:12:27 INFO - 'default_actions': ('clobber', 12:12:27 INFO - 'read-buildbot-config', 12:12:27 INFO - 'download-and-extract', 12:12:27 INFO - 'populate-webroot', 12:12:27 INFO - 'create-virtualenv', 12:12:27 INFO - 'install', 12:12:27 INFO - 'run-tests'), 12:12:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:12:27 INFO - 'download_minidump_stackwalk': True, 12:12:27 INFO - 'download_symbols': 'ondemand', 12:12:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:12:27 INFO - 'tooltool.py': '/tools/tooltool.py', 12:12:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:12:27 INFO - '/tools/misc-python/virtualenv.py')}, 12:12:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:12:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:12:27 INFO - 'installer_path': 'installer.exe', 12:12:27 INFO - 'log_level': 'info', 12:12:27 INFO - 'log_name': 'talos', 12:12:27 INFO - 'log_to_console': True, 12:12:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:12:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:12:27 INFO - 'opt_config_files': (), 12:12:27 INFO - 'pip_index': False, 12:12:27 INFO - 'sps_profile': False, 12:12:27 INFO - 'sps_profile_interval': 0, 12:12:27 INFO - 'suite': 'dromaeojs', 12:12:27 INFO - 'system_bits': '32', 12:12:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:12:27 INFO - 'title': 'talos-linux64-ix-063', 12:12:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:12:27 INFO - 'use_talos_json': True, 12:12:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:12:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:12:27 INFO - 'work_dir': 'build'} 12:12:27 INFO - ##### 12:12:27 INFO - ##### Running clobber step. 12:12:27 INFO - ##### 12:12:27 INFO - Running pre-action listener: _resource_record_pre_action 12:12:27 INFO - Running main action method: clobber 12:12:27 INFO - rmtree: /builds/slave/test/build 12:12:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:12:27 INFO - Running post-action listener: _resource_record_post_action 12:12:27 INFO - ##### 12:12:27 INFO - ##### Finished clobber step (success) 12:12:27 INFO - ##### 12:12:27 INFO - ##### 12:12:27 INFO - ##### Running read-buildbot-config step. 12:12:27 INFO - ##### 12:12:27 INFO - Running pre-action listener: _resource_record_pre_action 12:12:27 INFO - Running main action method: read_buildbot_config 12:12:27 INFO - Using buildbot properties: 12:12:27 INFO - { 12:12:27 INFO - "project": "", 12:12:27 INFO - "product": "firefox", 12:12:27 INFO - "script_repo_revision": "production", 12:12:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:12:27 INFO - "repository": "", 12:12:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 12:12:27 INFO - "buildid": "20160616093021", 12:12:27 INFO - "pgo_build": "True", 12:12:27 INFO - "basedir": "/builds/slave/test", 12:12:27 INFO - "buildnumber": 190, 12:12:27 INFO - "slavename": "talos-linux64-ix-063", 12:12:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:12:27 INFO - "platform": "ubuntu64_hw", 12:12:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:12:27 INFO - "branch": "fx-team", 12:12:27 INFO - "repo_path": "integration/fx-team", 12:12:27 INFO - "revision": "ea9d62d5f09b", 12:12:27 INFO - "stage_platform": "linux64-pgo", 12:12:27 INFO - "builduid": "d2374eb4927444028ad6db6f7e1b8a8d", 12:12:27 INFO - "slavebuilddir": "test" 12:12:27 INFO - } 12:12:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:12:27 INFO - Running post-action listener: _resource_record_post_action 12:12:27 INFO - ##### 12:12:27 INFO - ##### Finished read-buildbot-config step (success) 12:12:27 INFO - ##### 12:12:27 INFO - ##### 12:12:27 INFO - ##### Running download-and-extract step. 12:12:27 INFO - ##### 12:12:27 INFO - Running pre-action listener: _resource_record_pre_action 12:12:27 INFO - Running main action method: download_and_extract 12:12:27 INFO - mkdir: /builds/slave/test/build/tests 12:12:27 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')]} 12:12:27 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:12:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:12:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:12:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:12:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:12:29 INFO - retry: attempt #1 caught exception: '' 12:12:29 INFO - retry: Failed, sleeping 30 seconds before retrying 12:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 #2 12:13:09 INFO - Downloaded 1361 bytes. 12:13:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:13:09 INFO - Using the following test package requirements: 12:13:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:13:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:13:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'jsshell-linux-x86_64.zip'], 12:13:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:13:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:13:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:13:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:13:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:13:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:13:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:13:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:13:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:09 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:10 INFO - Downloaded 24220718 bytes. 12:13:10 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'] 12:13:10 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 12:13:11 INFO - Return code: 0 12:13:11 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 12:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:13:11 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:13:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:13:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:13 INFO - Downloaded 24220718 bytes. 12:13:13 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'] 12:13:13 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 12:13:16 INFO - Return code: 0 12:13: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')]} 12:13:16 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:18 INFO - Downloaded 14405384 bytes. 12:13: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'] 12:13: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 12:13:18 INFO - Return code: 0 12:13: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')]} 12:13:18 INFO - https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G1__st0QScSVAvTR6pLqjA/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 12:13:19 INFO - Downloaded 60097925 bytes. 12:13:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:19 INFO - mkdir: /builds/slave/test/properties 12:13:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:13:19 INFO - Writing to file /builds/slave/test/properties/build_url 12:13:19 INFO - Contents: 12:13:19 INFO - build_url:https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:13:20 INFO - Running post-action listener: _resource_record_post_action 12:13:20 INFO - Running post-action listener: set_extra_try_arguments 12:13:20 INFO - ##### 12:13:20 INFO - ##### Finished download-and-extract step (success) 12:13:20 INFO - ##### 12:13:20 INFO - ##### 12:13:20 INFO - ##### Running populate-webroot step. 12:13:20 INFO - ##### 12:13:20 INFO - Running pre-action listener: _resource_record_pre_action 12:13:20 INFO - Running main action method: populate_webroot 12:13:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:13:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:13:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:13:20 INFO - '--tppagecycles', 12:13:20 INFO - '7'], 12:13:20 INFO - 'tests': ['tsvgm']}}, 12:13:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:13:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:13:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:13:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:13:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:13:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['damp', 'tps']}, 12:13:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'tests': ['damp', 'tps']}, 12:13:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['dromaeo_dom']}, 12:13:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:13:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['basic_compositor_video']}, 12:13:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:13:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['a11yr', 12:13:20 INFO - 'ts_paint', 12:13:20 INFO - 'tpaint', 12:13:20 INFO - 'sessionrestore', 12:13:20 INFO - 'sessionrestore_no_auto_restore', 12:13:20 INFO - 'tabpaint']}, 12:13:20 INFO - 'other-e10s': {'tests': ['a11yr', 12:13:20 INFO - 'ts_paint', 12:13:20 INFO - 'tpaint', 12:13:20 INFO - 'sessionrestore', 12:13:20 INFO - 'sessionrestore_no_auto_restore', 12:13:20 INFO - 'tabpaint']}, 12:13:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:13:20 INFO - 'ts_paint', 12:13:20 INFO - 'tpaint', 12:13:20 INFO - 'sessionrestore', 12:13:20 INFO - 'sessionrestore_no_auto_restore', 12:13:20 INFO - 'tabpaint']}, 12:13:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:13:20 INFO - 'ts_paint', 12:13:20 INFO - 'tpaint', 12:13:20 INFO - 'sessionrestore', 12:13:20 INFO - 'sessionrestore_no_auto_restore', 12:13:20 INFO - 'tabpaint']}, 12:13:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['a11yr', 12:13:20 INFO - 'ts_paint', 12:13:20 INFO - 'tpaint', 12:13:20 INFO - 'sessionrestore', 12:13:20 INFO - 'sessionrestore_no_auto_restore', 12:13:20 INFO - 'tabpaint']}, 12:13:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['a11yr', 12:13:20 INFO - 'ts_paint', 12:13:20 INFO - 'tpaint', 12:13:20 INFO - 'sessionrestore', 12:13:20 INFO - 'sessionrestore_no_auto_restore', 12:13:20 INFO - 'tabpaint']}, 12:13:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['tsvgx', 12:13:20 INFO - 'tsvgr_opacity', 12:13:20 INFO - 'tart', 12:13:20 INFO - 'tscrollx', 12:13:20 INFO - 'cart']}, 12:13:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:13:20 INFO - 'tsvgr_opacity', 12:13:20 INFO - 'tart', 12:13:20 INFO - 'tscrollx', 12:13:20 INFO - 'cart']}, 12:13:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'talos_options': ['--disable-e10s'], 12:13:20 INFO - 'tests': ['tp5o']}, 12:13:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'tests': ['tp5o']}, 12:13:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'talos_options': ['--disable-e10s', 12:13:20 INFO - '--xperf_path', 12:13:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:20 INFO - 'tests': ['tp5n']}, 12:13:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:13:20 INFO - 'talos_options': ['--xperf_path', 12:13:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:13:20 INFO - 'tests': ['tp5n']}}, 12:13:20 INFO - 'talos.zip': {'path': '', 12:13:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:13:20 INFO - Running post-action listener: _resource_record_post_action 12:13:20 INFO - ##### 12:13:20 INFO - ##### Finished populate-webroot step (success) 12:13:20 INFO - ##### 12:13:20 INFO - ##### 12:13:20 INFO - ##### Running create-virtualenv step. 12:13:20 INFO - ##### 12:13:20 INFO - Running pre-action listener: _resource_record_pre_action 12:13:20 INFO - Running main action method: create_virtualenv 12:13:20 INFO - Creating virtualenv /builds/slave/test/build/venv 12:13: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 12:13:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:13:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:13:20 INFO - Using real prefix '/usr' 12:13:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:13:21 INFO - Installing distribute.............................................................................................................................................................................................done. 12:13:23 INFO - Installing pip.................done. 12:13:23 INFO - Return code: 0 12:13:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13: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 12:13: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 12:13:23 INFO - Using env: {'DISPLAY': ':0', 12:13:23 INFO - 'HOME': '/home/cltbld', 12:13:23 INFO - 'LANG': 'en_US.UTF-8', 12:13:23 INFO - 'LANGUAGE': 'en_US:en', 12:13:23 INFO - 'LOGNAME': 'cltbld', 12:13:23 INFO - 'MAIL': '/var/mail/cltbld', 12:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:23 INFO - 'MOZ_NO_REMOTE': '1', 12:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:23 INFO - 'NO_EM_RESTART': '1', 12:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:23 INFO - 'PWD': '/builds/slave/test', 12:13:23 INFO - 'SHELL': '/bin/bash', 12:13:23 INFO - 'SHLVL': '1', 12:13:23 INFO - 'TERM': 'linux', 12:13:23 INFO - 'TMOUT': '86400', 12:13:23 INFO - 'USER': 'cltbld', 12:13:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:23 INFO - '_': '/tools/buildbot/bin/python'} 12:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13: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 12:13:23 INFO - Cleaning up... 12:13:23 INFO - Return code: 0 12:13:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13: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 12:13: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 12:13:23 INFO - Using env: {'DISPLAY': ':0', 12:13:23 INFO - 'HOME': '/home/cltbld', 12:13:23 INFO - 'LANG': 'en_US.UTF-8', 12:13:23 INFO - 'LANGUAGE': 'en_US:en', 12:13:23 INFO - 'LOGNAME': 'cltbld', 12:13:23 INFO - 'MAIL': '/var/mail/cltbld', 12:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:23 INFO - 'MOZ_NO_REMOTE': '1', 12:13:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:23 INFO - 'NO_EM_RESTART': '1', 12:13:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:23 INFO - 'PWD': '/builds/slave/test', 12:13:23 INFO - 'SHELL': '/bin/bash', 12:13:23 INFO - 'SHLVL': '1', 12:13:23 INFO - 'TERM': 'linux', 12:13:23 INFO - 'TMOUT': '86400', 12:13:23 INFO - 'USER': 'cltbld', 12:13:23 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:23 INFO - '_': '/tools/buildbot/bin/python'} 12:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:23 INFO - Downloading/unpacking psutil>=3.1.1 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:13:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:25 INFO - Installing collected packages: psutil 12:13:25 INFO - Running setup.py install for psutil 12:13:25 INFO - building 'psutil._psutil_linux' extension 12:13: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 12:13: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 12:13:25 INFO - building 'psutil._psutil_posix' extension 12:13:25 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 12:13: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:13:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:13:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:13:25 INFO - Successfully installed psutil 12:13:25 INFO - Cleaning up... 12:13:25 INFO - Return code: 0 12:13:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:13:25 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')]} 12:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:25 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')]} 12:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:25 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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13:25 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 12:13:25 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 12:13:25 INFO - Using env: {'DISPLAY': ':0', 12:13:25 INFO - 'HOME': '/home/cltbld', 12:13:25 INFO - 'LANG': 'en_US.UTF-8', 12:13:25 INFO - 'LANGUAGE': 'en_US:en', 12:13:25 INFO - 'LOGNAME': 'cltbld', 12:13:25 INFO - 'MAIL': '/var/mail/cltbld', 12:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:25 INFO - 'MOZ_NO_REMOTE': '1', 12:13:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:25 INFO - 'NO_EM_RESTART': '1', 12:13:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:25 INFO - 'PWD': '/builds/slave/test', 12:13:25 INFO - 'SHELL': '/bin/bash', 12:13:25 INFO - 'SHLVL': '1', 12:13:25 INFO - 'TERM': 'linux', 12:13:25 INFO - 'TMOUT': '86400', 12:13:25 INFO - 'USER': 'cltbld', 12:13:25 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:25 INFO - '_': '/tools/buildbot/bin/python'} 12:13:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:13:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:13:28 INFO - Installing collected packages: mozsystemmonitor 12:13:28 INFO - Running setup.py install for mozsystemmonitor 12:13:28 INFO - Successfully installed mozsystemmonitor 12:13:28 INFO - Cleaning up... 12:13:28 INFO - Return code: 0 12:13:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13: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 12:13: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 12:13:28 INFO - Using env: {'DISPLAY': ':0', 12:13:28 INFO - 'HOME': '/home/cltbld', 12:13:28 INFO - 'LANG': 'en_US.UTF-8', 12:13:28 INFO - 'LANGUAGE': 'en_US:en', 12:13:28 INFO - 'LOGNAME': 'cltbld', 12:13:28 INFO - 'MAIL': '/var/mail/cltbld', 12:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:28 INFO - 'MOZ_NO_REMOTE': '1', 12:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:28 INFO - 'NO_EM_RESTART': '1', 12:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:28 INFO - 'PWD': '/builds/slave/test', 12:13:28 INFO - 'SHELL': '/bin/bash', 12:13:28 INFO - 'SHLVL': '1', 12:13:28 INFO - 'TERM': 'linux', 12:13:28 INFO - 'TMOUT': '86400', 12:13:28 INFO - 'USER': 'cltbld', 12:13:28 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:28 INFO - '_': '/tools/buildbot/bin/python'} 12:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:28 INFO - Downloading/unpacking jsonschema==2.5.1 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:13:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:30 INFO - Downloading functools32-3.2.3-2.tar.gz 12:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:13:30 INFO - warning: no files found matching '*.txt' 12:13:30 INFO - no previously-included directories found matching 'build' 12:13:30 INFO - no previously-included directories found matching 'dist' 12:13:30 INFO - no previously-included directories found matching '.git*' 12:13:30 INFO - Installing collected packages: jsonschema, functools32 12:13:30 INFO - Running setup.py install for functools32 12:13:30 INFO - warning: no files found matching '*.txt' 12:13:30 INFO - no previously-included directories found matching 'build' 12:13:30 INFO - no previously-included directories found matching 'dist' 12:13:30 INFO - no previously-included directories found matching '.git*' 12:13:30 INFO - Successfully installed jsonschema functools32 12:13:30 INFO - Cleaning up... 12:13:30 INFO - Return code: 0 12:13:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:13:30 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')]} 12:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:30 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')]} 12:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:30 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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13:30 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 12:13:30 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 12:13:30 INFO - Using env: {'DISPLAY': ':0', 12:13:30 INFO - 'HOME': '/home/cltbld', 12:13:30 INFO - 'LANG': 'en_US.UTF-8', 12:13:30 INFO - 'LANGUAGE': 'en_US:en', 12:13:30 INFO - 'LOGNAME': 'cltbld', 12:13:30 INFO - 'MAIL': '/var/mail/cltbld', 12:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:30 INFO - 'MOZ_NO_REMOTE': '1', 12:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:30 INFO - 'NO_EM_RESTART': '1', 12:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:30 INFO - 'PWD': '/builds/slave/test', 12:13:30 INFO - 'SHELL': '/bin/bash', 12:13:30 INFO - 'SHLVL': '1', 12:13:30 INFO - 'TERM': 'linux', 12:13:30 INFO - 'TMOUT': '86400', 12:13:30 INFO - 'USER': 'cltbld', 12:13:30 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:30 INFO - '_': '/tools/buildbot/bin/python'} 12:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:31 INFO - Downloading/unpacking blobuploader==1.2.4 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:13:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:13:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:33 INFO - Downloading docopt-0.6.1.tar.gz 12:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:13:33 INFO - Installing collected packages: blobuploader, requests, docopt 12:13:33 INFO - Running setup.py install for blobuploader 12:13:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:13:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:13:33 INFO - Running setup.py install for requests 12:13:34 INFO - Running setup.py install for docopt 12:13:34 INFO - Successfully installed blobuploader requests docopt 12:13:34 INFO - Cleaning up... 12:13:34 INFO - Return code: 0 12:13:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13: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 12:13: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 12:13:34 INFO - Using env: {'DISPLAY': ':0', 12:13:34 INFO - 'HOME': '/home/cltbld', 12:13:34 INFO - 'LANG': 'en_US.UTF-8', 12:13:34 INFO - 'LANGUAGE': 'en_US:en', 12:13:34 INFO - 'LOGNAME': 'cltbld', 12:13:34 INFO - 'MAIL': '/var/mail/cltbld', 12:13:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:34 INFO - 'MOZ_NO_REMOTE': '1', 12:13:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:34 INFO - 'NO_EM_RESTART': '1', 12:13:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:34 INFO - 'PWD': '/builds/slave/test', 12:13:34 INFO - 'SHELL': '/bin/bash', 12:13:34 INFO - 'SHLVL': '1', 12:13:34 INFO - 'TERM': 'linux', 12:13:34 INFO - 'TMOUT': '86400', 12:13:34 INFO - 'USER': 'cltbld', 12:13:34 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:34 INFO - '_': '/tools/buildbot/bin/python'} 12:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:34 INFO - Running setup.py (path:/tmp/pip-TnWS09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:34 INFO - Running setup.py (path:/tmp/pip-diBul8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:34 INFO - Running setup.py (path:/tmp/pip-sDEsEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:34 INFO - Running setup.py (path:/tmp/pip-zEu4rU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:34 INFO - Running setup.py (path:/tmp/pip-imH9K3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:34 INFO - Running setup.py (path:/tmp/pip-cpb397-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:35 INFO - Running setup.py (path:/tmp/pip-fnFjVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:35 INFO - Running setup.py (path:/tmp/pip-S_Tgky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:35 INFO - Running setup.py (path:/tmp/pip-mbeGUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:35 INFO - Running setup.py (path:/tmp/pip-wHtxmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:35 INFO - Running setup.py (path:/tmp/pip-CWHxmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:35 INFO - Running setup.py (path:/tmp/pip-rLzJx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:35 INFO - Running setup.py (path:/tmp/pip-aE4hH5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:35 INFO - Running setup.py (path:/tmp/pip-fD7z9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:35 INFO - Running setup.py (path:/tmp/pip-YbD4ca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:35 INFO - Running setup.py (path:/tmp/pip-Jk8FoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:35 INFO - Running setup.py (path:/tmp/pip-8XnESD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:13:35 INFO - Running setup.py install for manifestparser 12:13:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:13:35 INFO - Running setup.py install for mozcrash 12:13:36 INFO - Running setup.py install for mozdebug 12:13:36 INFO - Running setup.py install for mozdevice 12:13:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Running setup.py install for mozfile 12:13:36 INFO - Running setup.py install for mozhttpd 12:13:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Running setup.py install for mozinfo 12:13:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Running setup.py install for mozInstall 12:13:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Running setup.py install for mozleak 12:13:36 INFO - Running setup.py install for mozlog 12:13:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Running setup.py install for moznetwork 12:13:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:13:36 INFO - Running setup.py install for mozprocess 12:13:37 INFO - Running setup.py install for mozprofile 12:13:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:13:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:13:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:13:37 INFO - Running setup.py install for mozrunner 12:13:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:13:37 INFO - Running setup.py install for mozscreenshot 12:13:37 INFO - Running setup.py install for moztest 12:13:37 INFO - Running setup.py install for mozversion 12:13:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:13:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:13:37 INFO - Cleaning up... 12:13:37 INFO - Return code: 0 12:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13: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 12:13: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 12:13:37 INFO - Using env: {'DISPLAY': ':0', 12:13:37 INFO - 'HOME': '/home/cltbld', 12:13:37 INFO - 'LANG': 'en_US.UTF-8', 12:13:37 INFO - 'LANGUAGE': 'en_US:en', 12:13:37 INFO - 'LOGNAME': 'cltbld', 12:13:37 INFO - 'MAIL': '/var/mail/cltbld', 12:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:37 INFO - 'MOZ_NO_REMOTE': '1', 12:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:37 INFO - 'NO_EM_RESTART': '1', 12:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:37 INFO - 'PWD': '/builds/slave/test', 12:13:37 INFO - 'SHELL': '/bin/bash', 12:13:37 INFO - 'SHLVL': '1', 12:13:37 INFO - 'TERM': 'linux', 12:13:37 INFO - 'TMOUT': '86400', 12:13:37 INFO - 'USER': 'cltbld', 12:13:37 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:37 INFO - '_': '/tools/buildbot/bin/python'} 12:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:13:37 INFO - Running setup.py (path:/tmp/pip-xqkaPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:13:37 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)) 12:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:13:37 INFO - Running setup.py (path:/tmp/pip-9AIXN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:13:37 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)) 12:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:13:37 INFO - Running setup.py (path:/tmp/pip-dLKXMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:13:38 INFO - Running setup.py (path:/tmp/pip-I_Nrlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:13:38 INFO - Running setup.py (path:/tmp/pip-lc9frC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:13:38 INFO - Running setup.py (path:/tmp/pip-HT9vym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:13:38 INFO - Running setup.py (path:/tmp/pip-8Sb1Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:13:38 INFO - Running setup.py (path:/tmp/pip-W3o0da-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:13:38 INFO - Running setup.py (path:/tmp/pip-lW06Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:13:38 INFO - Running setup.py (path:/tmp/pip-C83Br8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:13:38 INFO - Running setup.py (path:/tmp/pip-_IUPTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:13: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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:13:38 INFO - Running setup.py (path:/tmp/pip-l5pVtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:13:38 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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:13:38 INFO - Running setup.py (path:/tmp/pip-L4uTvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:13:38 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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:13:38 INFO - Running setup.py (path:/tmp/pip-mUAuNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:13:38 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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:38 INFO - Running setup.py (path:/tmp/pip-LLbBrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:13:38 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)) 12:13:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:13:38 INFO - Running setup.py (path:/tmp/pip-eA84hD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:13: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)) 12:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:13:39 INFO - Running setup.py (path:/tmp/pip-yrbEfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:40 INFO - Downloading blessings-1.6.tar.gz 12:13:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:13:41 INFO - Installing collected packages: blessings 12:13:41 INFO - Running setup.py install for blessings 12:13:41 INFO - Successfully installed blessings 12:13:41 INFO - Cleaning up... 12:13:41 INFO - Return code: 0 12:13:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:13:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:41 INFO - Reading from file tmpfile_stdout 12:13:41 INFO - Current package versions: 12:13:41 INFO - argparse == 1.2.1 12:13:41 INFO - blessings == 1.6 12:13:41 INFO - blobuploader == 1.2.4 12:13:41 INFO - docopt == 0.6.1 12:13:41 INFO - functools32 == 3.2.3-2 12:13:41 INFO - jsonschema == 2.5.1 12:13:41 INFO - manifestparser == 1.1 12:13:41 INFO - mozInstall == 1.12 12:13:41 INFO - mozcrash == 0.17 12:13:41 INFO - mozdebug == 0.1 12:13:41 INFO - mozdevice == 0.48 12:13:41 INFO - mozfile == 1.2 12:13:41 INFO - mozhttpd == 0.7 12:13:41 INFO - mozinfo == 0.9 12:13:41 INFO - mozleak == 0.1 12:13:41 INFO - mozlog == 3.2 12:13:41 INFO - moznetwork == 0.27 12:13:41 INFO - mozprocess == 0.22 12:13:41 INFO - mozprofile == 0.28 12:13:41 INFO - mozrunner == 6.11 12:13:41 INFO - mozscreenshot == 0.1 12:13:41 INFO - mozsystemmonitor == 0.3 12:13:41 INFO - moztest == 0.7 12:13:41 INFO - mozversion == 1.4 12:13:41 INFO - psutil == 3.1.1 12:13:41 INFO - requests == 1.2.3 12:13:41 INFO - wsgiref == 0.1.2 12:13:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13: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 12:13: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 12:13:41 INFO - Using env: {'DISPLAY': ':0', 12:13:41 INFO - 'HOME': '/home/cltbld', 12:13:41 INFO - 'LANG': 'en_US.UTF-8', 12:13:41 INFO - 'LANGUAGE': 'en_US:en', 12:13:41 INFO - 'LOGNAME': 'cltbld', 12:13:41 INFO - 'MAIL': '/var/mail/cltbld', 12:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:41 INFO - 'MOZ_NO_REMOTE': '1', 12:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:41 INFO - 'NO_EM_RESTART': '1', 12:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:41 INFO - 'PWD': '/builds/slave/test', 12:13:41 INFO - 'SHELL': '/bin/bash', 12:13:41 INFO - 'SHLVL': '1', 12:13:41 INFO - 'TERM': 'linux', 12:13:41 INFO - 'TMOUT': '86400', 12:13:41 INFO - 'USER': 'cltbld', 12:13:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:41 INFO - '_': '/tools/buildbot/bin/python'} 12:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13: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)) 12:13:41 INFO - Cleaning up... 12:13:41 INFO - Return code: 0 12:13:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:41 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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13:41 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 12:13:41 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 12:13:41 INFO - Using env: {'DISPLAY': ':0', 12:13:41 INFO - 'HOME': '/home/cltbld', 12:13:41 INFO - 'LANG': 'en_US.UTF-8', 12:13:41 INFO - 'LANGUAGE': 'en_US:en', 12:13:41 INFO - 'LOGNAME': 'cltbld', 12:13:41 INFO - 'MAIL': '/var/mail/cltbld', 12:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:41 INFO - 'MOZ_NO_REMOTE': '1', 12:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:41 INFO - 'NO_EM_RESTART': '1', 12:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:41 INFO - 'PWD': '/builds/slave/test', 12:13:41 INFO - 'SHELL': '/bin/bash', 12:13:41 INFO - 'SHLVL': '1', 12:13:41 INFO - 'TERM': 'linux', 12:13:41 INFO - 'TMOUT': '86400', 12:13:41 INFO - 'USER': 'cltbld', 12:13:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:41 INFO - '_': '/tools/buildbot/bin/python'} 12:13:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:13:41 INFO - Cleaning up... 12:13:41 INFO - Return code: 0 12:13:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:13: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')]} 12:13:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:13:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13: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')]} 12:13:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:13:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:13:41 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 0x7f0f23e8cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13db350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, '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': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', '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 12:13:41 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 12:13:41 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 12:13:41 INFO - Using env: {'DISPLAY': ':0', 12:13:41 INFO - 'HOME': '/home/cltbld', 12:13:41 INFO - 'LANG': 'en_US.UTF-8', 12:13:41 INFO - 'LANGUAGE': 'en_US:en', 12:13:41 INFO - 'LOGNAME': 'cltbld', 12:13:41 INFO - 'MAIL': '/var/mail/cltbld', 12:13:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:13:41 INFO - 'MOZ_NO_REMOTE': '1', 12:13:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:13:41 INFO - 'NO_EM_RESTART': '1', 12:13:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:13:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:13:41 INFO - 'PWD': '/builds/slave/test', 12:13:41 INFO - 'SHELL': '/bin/bash', 12:13:41 INFO - 'SHLVL': '1', 12:13:41 INFO - 'TERM': 'linux', 12:13:41 INFO - 'TMOUT': '86400', 12:13:41 INFO - 'USER': 'cltbld', 12:13:41 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:13:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:13:41 INFO - '_': '/tools/buildbot/bin/python'} 12:13:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:13:42 INFO - Downloading/unpacking flake8 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:13:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 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 12:13:43 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 12:13:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:13:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13: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 12:13:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:44 INFO - no previously-included directories found matching 'docs/_build' 12:13:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:13:44 INFO - Running setup.py install for pep8 12:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:13:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:13:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:13:44 INFO - no previously-included directories found matching 'docs/_build' 12:13:44 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:13:44 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:13:44 INFO - Cleaning up... 12:13:44 INFO - Return code: 0 12:13:44 INFO - Running post-action listener: _resource_record_post_action 12:13:44 INFO - Running post-action listener: _start_resource_monitoring 12:13:44 INFO - Starting resource monitoring. 12:13:44 INFO - ##### 12:13:44 INFO - ##### Finished create-virtualenv step (success) 12:13:44 INFO - ##### 12:13:44 INFO - ##### 12:13:44 INFO - ##### Running install step. 12:13:44 INFO - ##### 12:13:44 INFO - Running pre-action listener: _resource_record_pre_action 12:13:44 INFO - Running main action method: install 12:13:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:13:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:13:45 INFO - Reading from file tmpfile_stdout 12:13:45 INFO - Detecting whether we're running mozinstall >=1.0... 12:13:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:13:45 INFO - Reading from file tmpfile_stdout 12:13:45 INFO - Output received: 12:13:45 INFO - Usage: mozinstall [options] installer 12:13:45 INFO - Options: 12:13:45 INFO - -h, --help show this help message and exit 12:13:45 INFO - -d DEST, --destination=DEST 12:13:45 INFO - Directory to install application into. [default: 12:13:45 INFO - "/builds/slave/test"] 12:13:45 INFO - --app=APP Application being installed. [default: firefox] 12:13:45 INFO - mkdir: /builds/slave/test/build/application 12:13: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'] 12:13: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 12:14:02 INFO - Reading from file tmpfile_stdout 12:14:02 INFO - Output received: 12:14:02 INFO - /builds/slave/test/build/application/firefox/firefox 12:14:02 INFO - Running post-action listener: _resource_record_post_action 12:14:02 INFO - ##### 12:14:02 INFO - ##### Finished install step (success) 12:14:02 INFO - ##### 12:14:02 INFO - ##### 12:14:02 INFO - ##### Running run-tests step. 12:14:02 INFO - ##### 12:14:02 INFO - Running pre-action listener: _resource_record_pre_action 12:14:02 INFO - Running main action method: run_tests 12:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:02 INFO - Python 2.7.3 12:14:02 INFO - Return code: 0 12:14:02 INFO - grabbing minidump binary from tooltool 12:14: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')]} 12:14: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 0x146a1c0>, '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 0x146b0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x146b550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14: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 12:14: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 12:14: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 12:14:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:02 INFO - Return code: 0 12:14:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:14:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:14:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:14:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:14:03 INFO - Return code: 0 12:14: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/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 12:14: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/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 12:14:03 INFO - Using env: {'DISPLAY': ':0', 12:14:03 INFO - 'HOME': '/home/cltbld', 12:14:03 INFO - 'LANG': 'en_US.UTF-8', 12:14:03 INFO - 'LANGUAGE': 'en_US:en', 12:14:03 INFO - 'LOGNAME': 'cltbld', 12:14:03 INFO - 'MAIL': '/var/mail/cltbld', 12:14:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:03 INFO - 'MOZ_NO_REMOTE': '1', 12:14:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:03 INFO - 'NO_EM_RESTART': '1', 12:14:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:03 INFO - 'PWD': '/builds/slave/test', 12:14:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:03 INFO - 'SHELL': '/bin/bash', 12:14:03 INFO - 'SHLVL': '1', 12:14:03 INFO - 'TERM': 'linux', 12:14:03 INFO - 'TMOUT': '86400', 12:14:03 INFO - 'USER': 'cltbld', 12:14:03 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195', 12:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:03 INFO - '_': '/tools/buildbot/bin/python'} 12:14: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/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 12:14:03 INFO - mozversion application_buildid: 20160616093021 12:14:03 INFO - mozversion application_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 12:14:03 INFO - mozversion application_display_name: Nightly 12:14:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:03 INFO - mozversion application_name: Firefox 12:14:03 INFO - mozversion application_remotingname: firefox 12:14:03 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:14:03 INFO - mozversion application_vendor: Mozilla 12:14:03 INFO - mozversion application_version: 50.0a1 12:14:03 INFO - mozversion platform_buildid: 20160616093021 12:14:03 INFO - mozversion platform_changeset: ea9d62d5f09bbcafdd18290a01c07629e40d69b8 12:14:03 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:14:03 INFO - mozversion platform_version: 50.0a1 12:14:03 INFO - using testdate: 1466104443 12:14:03 INFO - actual date: 1466104443 12:14:03 INFO - starting webserver on 'localhost:59119' 12:14:03 INFO - SUITE-START | Running 2 tests 12:14:03 INFO - TEST-START | dromaeo_css 12:14:03 INFO - operating with platform_type : linux_ 12:14:03 INFO - Initialising browser for dromaeo_css test... 12:14:03 INFO - TEST-INFO | started process 14905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpamAcfw/profile http://localhost:59119/getInfo.html) 12:14:18 INFO - PROCESS | 14905 | __metrics Screen width/height:1600/1200 12:14:18 INFO - PROCESS | 14905 | colorDepth:24 12:14:18 INFO - PROCESS | 14905 | Browser inner width/height: 1024/697 12:14:18 INFO - PROCESS | 14905 | __metrics 12:14:20 INFO - PROCESS | 14905 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:21 INFO - PROCESS | 14905 | console.error: PushService: 12:14:21 INFO - PROCESS | 14905 | stateChangeProcessEnqueue: Error transitioning state 12:14:21 INFO - PROCESS | 14905 | UnknownError 12:14:22 INFO - TEST-INFO | 14905: exit 0 12:14:22 INFO - Browser initialized. 12:14:22 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:22 INFO - TEST-INFO | started process 14988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpamAcfw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:14:34 INFO - PROCESS | 14988 | RSS: Main: 173969408 12:14:34 INFO - PROCESS | 14988 | 12:15:24 INFO - PROCESS | 14988 | 1466104524866 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] 12:17:34 INFO - PROCESS | 14988 | Cycle 1(1): loaded http://localhost:59119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59119/tests/dromaeo/cssquery-ext.html) 12:17:35 INFO - PROCESS | 14988 | RSS: Main: 258506752 12:17:35 INFO - PROCESS | 14988 | 12:20:38 INFO - PROCESS | 14988 | Cycle 1(1): loaded http://localhost:59119/tests/dromaeo/cssquery-ext.html (next: http://localhost:59119/tests/dromaeo/cssquery-jquery.html) 12:20:38 INFO - PROCESS | 14988 | RSS: Main: 264048640 12:20:38 INFO - PROCESS | 14988 | 12:23:40 INFO - PROCESS | 14988 | Cycle 1(1): loaded http://localhost:59119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59119/tests/dromaeo/cssquery-mootools.html) 12:23:41 INFO - PROCESS | 14988 | RSS: Main: 271822848 12:23:41 INFO - PROCESS | 14988 | 12:26:43 INFO - PROCESS | 14988 | Cycle 1(1): loaded http://localhost:59119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59119/tests/dromaeo/cssquery-prototype.html) 12:26:43 INFO - PROCESS | 14988 | RSS: Main: 262549504 12:26:43 INFO - PROCESS | 14988 | 12:29:46 INFO - PROCESS | 14988 | Cycle 1(1): loaded http://localhost:59119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59119/tests/dromaeo/cssquery-yui.html) 12:29:47 INFO - PROCESS | 14988 | RSS: Main: 242294784 12:29:47 INFO - PROCESS | 14988 | 12:32:49 INFO - PROCESS | 14988 | Cycle 1(1): loaded http://localhost:59119/tests/dromaeo/cssquery-yui.html (next: http://localhost:59119/tests/dromaeo/cssquery-dojo.html) 12:32:49 INFO - PROCESS | 14988 | RSS: Main: 316825600 12:32:49 INFO - PROCESS | 14988 | 12:32:49 INFO - PROCESS | 14988 | __start_tp_report 12:32:49 INFO - PROCESS | 14988 | _x_x_mozilla_page_load 12:32:49 INFO - PROCESS | 14988 | _x_x_mozilla_page_load_details 12:32:49 INFO - PROCESS | 14988 | |i|pagename|runs| 12:32:49 INFO - PROCESS | 14988 | |0;dojo.html;3056.694330566944;3065.187725252807;3089.8918537851173;3102.906912792614;3127.577777000104;5134.332536770215;5190.766415511302;5239.947600523994;5295.788168473261;5312.681239125655;5175.068487672217;5231;5320.255164277004;5348.331458567679;5395.73021348933;4597.356370108188;4613.769311534418;4703.835365762199;4759.833405830796;4856.344393506884;4764.761761911908;4829.830955916544;4829.855104346875;4832.057748738997;4844.2733589961435;4658.883527911796;4695.741734204617;4712.128256272566;4755.239161734106;4815.927761083586;4729.692569982974;4729.787159577827;4739.597134243559;4805.879853003668;4836.492168322311;4748.596369308613;4765.594924431428;4771.8091276348905;4778.976105119487;4816.229403295491;5167.0957582422925;5206.193040078794;5249.47505249472;5273.2617433559335;5298.735063246861;5583.274174357348;5650.886982260373;5659.066254068074;5663.207150998864;5667.886642267132;5717.48542631161;5727.914081288784;5737.799177028825;5738.626989245728;5738.971305143447;5197.402298735656;5257.185136303879;5312.389075256357;5316.016536940679;5402.108652072364;5854.151148083504;5862.794802181903;5866.149408335853;5868.413158684183;5873.148393483007;5389.946100538945;5649.350324712628;5657.179708942181;5661.716914154275;5664.376918538957;5529.115341545334;5571.749271282721;5592.860178495489;5595;5595.804146854841;5518.53092487135;5590.105583106765;5602.579806514527;5609.691466969274;5609.915851262234;5545.223668686387;5563.109902415594;5570.41510641385;5604.467575580314;5619.494245517923;4351.086271882877;4359.498657654411;4392.011797345572;4398.912021759547;4399.098184872094;3870.0518372998795;3871.380579107329;3872.457855900176;3893.5327760668333;3906.257811015898;5225.608079394061;5277.129273669878;5358.19627055937;5370.167624018283;5416.458354164552;5632.52123569493;5633.380328163898;5641.26663533738;5752.539796816244;5758.309002919593;5423.701696406735;5438.91841622376;5443.42844001382;5444.3194600674915;5446.809361672323;4715.434147902273;4777.856664300077;4867.075255701406;4867.172580661296;4918.163912134945;5803.158542011469;5868.589198756132;5871.825634873043;5872.354041055481;5926.970365148233;5644.8024319148635;5645.096784514458;5706.514946229451;5709.058005429058;5728.140778883034;5480.232767412645;5543.584231182758;5702.657840529581;5775.624584402;5803.854903627274;5625.774969001194;5644.068728659725;5655.179998900218;5656.8020119295625;5704.172894930129;5636.661800291996;5680.289963754531;5704.144378343116;5730.369659337553;5738.48353648157;5257.053730328577;5465.316835395575;5531.9723401382735;5544.029794785815;5552.750126244409;5549.334079910275;5564.91652625219;5569.220309156803;5577.721113944368;5578.748956297058;5501.862453438696;5503.147012213113;5504.834854954358;5508.20131080983;5550.111982082847;5416.945830541802;5484.040292948798;5550.916736248879;5554.222408862844;5632.436756324335;5449.918251226314;5459.508644222039;5461.208124821958;5464.754086066216;5472.425395333433 12:32:49 INFO - PROCESS | 14988 | |1;ext.html;595.7259660556144;613.806650904965;619.0806652121596;638.4126603524757;638.7221558621999;30601.540976885335;31275.374492510135;33437.16407089824;33449.66550334496;33497.83251083741;33377;42917.7854110729;43581;43593.7820310898;47801.28298075531;8699.260562852165;8880.333974951873;8882.955585222066;8887.066857979917;8891.822163556724;8819.603117859711;8917.821643567126;8920;8960.775980600472;8991.505467199302;8971.775705607346;8985.415947963395;8989.325800564951;9002.279817614608;9011.053839346872;8879.112088791102;8902.599383027778;8917.643294268222;8929.107089291052;8932.55337233139;8769.912300876973;8873.645054197825;8880.8667869982;8880.911190888073;8883.644654213824;41673.79163104195;41912.580874191175;41979;41981.79009104935;42080.31678732847;3487.5814902211896;3581.7313701472235;3604.42329227325;3630.110622897381;4018.3168861293357;32348.6765132348;32648.347033059443;32927;32928.6707132928;33881.83059084714;4316.48202215733;4432.490263619693;4486.977565112154;4525.094981003813;4570.131674981776;326848;330964;332575;333961;334162.99999999756;56124;56179;56345.71827140838;56355;56496.43503564994;61138.69430652818;61296;61384.38615613876;61400;61445.692771535854;16227.513174604781;16498.917505412395;16503.257353418885;16509.6698066038;16510.42213522521;12382.442790074469;12432.37838108091;12442.81335779964;12475.625731228078;12476.438560264809;16632.128054880603;18875.622487550172;18965.33621323247;18970.71543926842;19007.61984760297;5968.121400420582;6742.359475849787;7219.963900180465;7262.164851042197;7335.7432489862595;988.8467287570438;1006.7231511334442;1122.5678113926033;1128.9887101129048;1198.4487135917575;28762;30972.845135774176;31621.683783162334;31772.109573454207;31834.840825796186;1075.8816530181673;1090.7055095124272;1137.9601713939971;1146.2320245435578;1177.0289511153333;15813.841861581466;16061.196940152946;16184.919075404548;16219.837801622069;16328.428505002268;524785;526644;530325;530688;532718;55417.722911385186;55775.44224557783;55831.72084139553;55853.16220256699;55907;1254.5985284708806;1314.9013823963242;1357.4773712120707;1383.3498255819748;1398.6433459467567;30833.537496937115;32177.195570110933;32235;32278.83860580682;32497.187570310933;47061.76469117632;47700;47712.28431573599;47745.76127119342;47751.76124119357;400978;407720;411083;411657;414376;24388;25021.499570008862;25030.62454063154;26305.079322224396;26534.469310614066;42447.36328955006;45632;45685.77157114193;46186.769066154455;46448.53551464442;38469.807650961564;38774.364959153325;39378.60621393749;39721;39858.800705996284;38799.418008730456;38861.6113838858;39656.40515392214;39657.603423966546;40358;35177.120571985906;35229.647703522634;35309.47035794517;35342;39969.40045899255;32736.345273093928;34848.303033938675;35675.28649427049;35817.64182358143;35885.64114358927;25869.22392328233;26300.4739905197;26368.945242190865;26473.735262647126;26821.731782682706 12:32:49 INFO - PROCESS | 14988 | |2;jquery.html;351.1537195359184;364.54249916354973;367.8436664417622;373.2777076357249;389.29343242015756;19308.51728706783;19423.22307107716;19895.701564476545;20212;20261.2908548201;19060;19160.904195479005;19178;19476.51308717283;19626.313079042236;5329.467053294678;5469.480399362064;5659.066254068094;5712.457316554942;5713.257276554042;5521.033819081665;5633.436656334355;5638.605297629168;5651.717414129298;5656.547476201894;5642.548596112321;5643.971780141093;5644.74598643062;5697.230873832021;6287.151234583318;6201.100840378165;6247.625142491465;6251.3123556408755;6298.653574053448;6306.337834527378;5412.702301373423;5468.425815289417;5556.333240011184;5557.055300598908;5557.360903496109;12869.67825804353;13017.479300827956;13047.869521304856;16137;22691.319260422213;2269.4893648929024;2286.576983258086;2437.695288088989;2731.5902614607967;2868.7131286871354;8895.644174233023;9336.533173341306;9626.229901607854;9834.409935403899;10163.4918254087;1969.9704504432302;1997.6550557295345;2007.4880905369037;2017.3947815655392;2100.705901173837;79624.60187699083;81517;82853.58573207156;84026;84042;10382.117520010883;10414.917016596712;10424.895751042393;10611.363318200933;10629.30909490896;14310.427582896567;14415.927920360331;14426;14438.639034024023;14459.27703614815;7919.128895821455;8129.634166462523;8140.511569305861;8174.651182554812;8288.336933045342;7221.205667376585;7333.1566869809585;7463.738769143162;7538.585377804164;8052.718154864551;4157.605027522381;4295.806688698954;4468.843590474317;4616.1229366420275;4631.745254011062;1791.3372052340717;1885.8019907909472;1894.6779047561672;1910.866239363259;1916.2430839818194;874.5408660453186;922.9123233292827;1006.5017816181037;1011.5144730529387;1019.2814066083394;18074.819251807312;18778.906105469385;19385.321513746952;19462.70805937912;19631;971.1696499492832;975.4050029482011;977.1449981266392;1013.6046941692746;1039.8024375368657;10213.642522511676;10693.091087257515;10760.946195268974;10770.192235582363;10810.243282970117;492134;496001;506085;506963;509992;88822.11177888268;89635;91066;91331.54334228286;91465.54267228622;905.2079430498445;929.7164364868645;966.0966995858895;972.4019727867311;983.6213057972589;16479.670406592042;16700.83299166993;17108.315667373663;17171.57071073183;17413.564660883578;40442;40525.79737101296;41260.58739412567;42130.946726332084;42438;58503.4149658515;59601;60091.898911197335;61018.389816103045;61694.38305616887;8342.916570834213;8362.498250105013;8362.581870906308;8381.203785640355;8574.31405487572;9518.95240523793;12881.162724422882;13205.20768753878;13582.117162384413;13857.584272471842;11381.54473821071;12012.510752982202;12058.758824823279;12207.450664720287;12208.938955305166;10992.835107473555;11705.765884682089;11739.589114381297;11796.233244839059;11815.40922953866;12005.699857503283;12017.09871759604;12227.816582751087;12355.3822308886;12464.626061218178;8276.958615207126;8310.252077313071;8520.829583408173;8527.488350698977;8708.825823483621;11006.394648294421;11956.760864782482;12235.632931012084;12350.258984460961;12376.07179461526 12:32:49 INFO - PROCESS | 14988 | |3;mootools.html;1296.2352212194814;1455.890808189386;1459.5037687186357;1587.4047232287892;1753.5090174751067;8481.787955301113;8807.691730789416;8812.38313318068;9132.95433522833;9136.857892763404;8801.163889430494;9046.140616641409;9047.457152570834;9052.275817934566;9064.95467522663;2325.348902307348;2360.0559776089617;2360.280114565057;2360.433495960974;2363.9645405318934;2313.768623137681;2318.8492747971327;2353.1175809071597;2353.352827972304;2355.0697474497565;2271.5570463759573;2303.873286969216;2313.144136669426;2337.4857531343077;2337.5909215887236;2247.370736193868;2251.74104977928;2256.3682168992627;2256.9210077647285;2259.2318611672026;2222.3110835641005;2228.6768418579377;2233.129079658934;2234.1175235781775;2239.880059970015;8995.145461181177;9091.954540227256;9173.633054677804;9182.035886231915;9291.860622090675;5217.217417387422;5366.570674346043;5377.46225377463;5390.434004429557;5403.5136837684795;3365.3437579671972;3380.408428525023;3442.621311655716;3460.0311912664492;3491.092315997859;1139.789139009286;1176.647005898227;1183.5502509046507;1189.3220864107461;1202.9157958942878;12997.805032924514;13167.078304518687;13177.934110329386;13180.34098295091;13208.933955330258;4436.822527098944;4558.293464513005;4567.4062371892105;4579.038401935564;4636.165490211727;10008.79982400348;10019.298649094639;10022.699319020441;10022.899771002343;10042.19662427004;5122.513361230677;5145.382554093458;5181.766820493087;5199.63602547818;5247.868803279872;4013.8795836124964;4092.2224777292217;4207.579242075829;4635.351050852883;4829.323894654751;3574.8391322390553;3622.4747411625167;3646.9817650911577;3665.9368783052614;3732.850685972585;1103.7406209540752;1115.4255558387438;1119.5350390541423;1133.7675776465805;1146.220570012383;925.5372313843078;983.5868935047297;999.2305924438142;1021.5658345203259;1023.1610079734695;6128.264608247039;6206.658633775095;6264.140765861374;6464.935350646528;6575.276719560845;962.4658314635304;964.1370972979284;977.9070988256104;1000.5697550053546;1014.4319181258519;4297.269464191032;4474.798634061475;4527.366168736379;4532.161550113239;4571.794269257892;11398.772024559463;11723.648290551297;11788.056955443544;11815.940920295343;11824.527018919147;10232.897671023344;10598.682039538671;10617.734556636145;10959;10976.451177441097;8466.703665371682;8616.405964896514;8686.47881127147;8687.826243475096;8699.782505437415;6294.464970477377;6510.18622672166;6531.836704082246;6615.636140012153;6663.167104111986;10472.68581942543;10654.520546575268;10835.620753273914;10918.945405272923;10931.18016148776;10503.42231177262;10885.891141088488;10891.618793342512;11030.889691103308;11037.337759734442;7120.430365570845;7696.422768292288;7912.84174316499;8096.959515202622;8264.83470330602;8309.501429914224;8328.417010809428;8362.958185209034;8397.286230670461;8397.70608028716;7788.104367997753;7928.881066784118;7946.284834364935;8089.878651820345;8106.310963568163;7471.9626401867645;7612.657430415534;7715;7828.491148075357;7841;7405.629718513945;7445.851082978202;7622.69509219625;7629.389648828192;7630.427717921067;5436.211749296409;5621.4659607337235;5634.943650563442;5656.236408084856;5717.37108918027;5398.946010539844;5458.863528411822;5473.72631368422;5575.498205161555;5850.151727999501 12:32:49 INFO - PROCESS | 14988 | |4;prototype.html;290.6991264041716;304.61922596754056;306.33372414997376;308.2063686008527;315.28745036218146;5145.434002259748;5282.6492210966135;5331.2536244925695;5375.4355792641745;5376.327959005124;5275.261463395128;5311.893762124755;5323.627346085766;5324.254604355384;5368.46315368463;4171.728837625545;4184.2677531431955;4187.1416359646355;4199.076203235283;4205.369194620801;3862.633049860259;3962.2075584882996;4070.2266569351877;4183.393407955845;4211.199872024321;4077.103037331782;4103.8563650272245;4111.7944102794745;4122.793860306988;4124.896877578055;4113.56807535209;4119.361498967664;4123.546409894909;4136.875893723193;4139.3583994480905;3394.6096198937194;3650.5801832789302;3650.963490365089;3664.926701465956;3675.5956844747056;5140.691558506502;5149.588032957355;5159.097157997336;5197.844064678028;5206.323177986837;4620.607248383892;4627.449804315558;4638.814447422099;4673.299005149221;4702.788374523155;5236.6857988520815;5470.91793623096;5505.807296744635;5508.944910550883;5514.338279406497;3799.696024318048;3815.389537673959;3817.8854634361014;3848.134169811798;3849.268638958589;5678.4037676044245;5732.770689172428;5732.914006289909;5735.684537350444;5780.450857168605;3836.76979381238;3932.823022963916;3949.7827619481204;3973.2450834341385;3974.7018973577096;3942.4677668514955;3959.1685745993086;3987.627361719772;3992.740471869319;3993.6405723484445;4567.406237189144;4573.153966516205;4586.669865738898;4621.838235661736;4639.837605683852;5269.262303277545;5488.807891723771;5495.587830912617;5569.275994120739;5591.52472039873;1277.591170825327;1301.1412467771415;1304.7651422743998;1304.9412776425083;1326.257295914291;869.3523325122824;883.5008220355479;886.3662481325754;898.7213963671282;903.3225081189108;4660.86017419478;4788;4813.109574728686;4821.614270858323;4842.443119041355;5034.84895453137;5048;5110.565601923804;5282.894342113136;5708.743106560215;5344.599155063308;5436.483534064258;5444.292242008592;5457.154141108134;5458.5087342139395;3042.5284080967485;3044.2237229506336;3060.9540856887165;3061.219389055821;3063.218879185838;5778.88442231153;5913.497352725067;5929.288485381781;5933.258342707161;5941.792037278675;5804.303483581997;5827.921834460638;5853.414658534112;5884.882302353929;5895.882082358415;5590.552755779528;5804.245448091721;5804.984127777622;5898.144769008555;5949.464548190597;5625.915611265752;5630.296212973379;5639.746211420414;5674.546036317167;5686.687232202268;5569.888602227852;5646.2942132233475;5676.659400435987;5677.687727175045;5681.4034526374135;5623;5737.627054241461;5806.593538452268;5813.430373799135;5816.651000939788;3892.727509074451;3894.4547763313726;3914.6494459411456;3938.2517321708783;3945.2109578083923;5613.186088017296;5639.548836093185;5643.266375371176;5724.624280923536;5736.71316434185;5225.268462415341;5567.633755653912;5586.804461843979;5590.043484780294;5597.552195824405;5368.57051435892;5559.221708960829;5565.944340556543;5577.693226872561;5579.401286170479;5312.229726689686;5438.2386465894015;5480.3971563128825;5484.341878974548;5489.627593101724;5493.368262649847;5524.861878453071;5559.58303127259;5578.470045345685;5586.217929489793;5230.843074707765;5410.323709536308;5455.49973757204;5485.396606373375;5497.175423686479 12:32:49 INFO - PROCESS | 14988 | |5;yui.html;716.9032180655612;814.474663841822;815.4740192575789;824.766854309407;831.875218717192;14598.708025839476;15747.60630984226;15784;15791;16124.516264512069;15076.547703568911;15109.84890151098;15148.46980355685;15164.620884477894;15234.695306093872;747.7083937264471;774.9883751743729;777.6500574741389;778.9844203115935;778.9883151752729;765.8812884002989;774;774.0827119862952;774.4694884004475;774.6088225446142;814.8411059843332;815.4536460571431;815.7715839564902;816.3713940265992;816.4325793573469;804.4770898915693;812.4840726138885;813.3574476163853;814.0922870998853;814.5764202614637;590.9970450147765;591.9526437885002;592.1591340296789;592.7214209321612;592.863641362489;15697.293621787047;15748.2125893706;15752.291146898302;15754.054756714633;15799.131047792482;13448.1258718183;14176.787348189786;14418.783718244234;14425.206613636246;14446.494372696905;12234.510619575207;12302.446389912475;12499.125061245717;12577.11960162789;12611.810822837664;3833.099221682902;3895.5520115186832;3969.702272329587;4046.4941882264716;4050.8177132029127;73094.63452682702;74004.25995740028;74186.62906685432;75061.62469187619;76557;10919;11401.543938242543;11486.885131148749;11537.769244615229;11619.593314233962;20872.58254834895;20931.581368372852;21025.579488410145;21063.157473701187;21078.156873725187;8051.194880512019;8139.104698483162;8144.226298501633;8176.6320515576945;8262.297704695167;4487.730736155841;4597.149527337453;4693.718376897397;4757.26262429324;4873.853784386474;3486.18074752433;3597.5503062117236;3598.1544337080763;3598.3882739934274;3598.4602309653237;607.6475644126396;618.4959258204639;632.7975047984601;634.280092095475;641.0416427440913;625.3402660193449;702.2731472925498;722.9530080544748;742.8217227865273;785.6386062411241;9711.514424278757;9925.2059835213;9933.850992234979;10375.429351385596;10518.142451844078;650.3366566102549;652.1522021372197;716.1656669979519;722.4653756220359;725.2521423369759;4736.076465089274;4909.68087074339;4920.458749537548;4928.950710492921;4963.950360496421;114623.42688286673;116847;117794.41102794431;120486.39756801336;120865;66056;83768.58115709382;95996;100357;100605;88237;90466.99999999869;92036.07963920276;92407.53796230975;93136;9881.209503239867;10131.189504839742;10142.391456512632;10226.539805708611;10278.537465813906;50621;50693.49306506888;51531.74234128805;51903;52078.218826716875;45698.31452528148;64710.02934956073;66447;66536;76113;12637.494500219887;13273.469061237442;13315.933420332836;13400.32998350098;13431.798523022358;14967.925160374129;15045.362153586571;15099.39602415935;15342.309596068428;15966.920165399564;14365.712685746017;14458.783118253024;14601.85398146005;14801.555953321418;15108.622284442978;13430.19418834834;13460;13602.115862468909;13752.862471375558;14008.159510429407;13075;13503.189808611514;13619.727605448034;13802.93098534541;14023.50917717875;11392.770700319717;11471.4264286787;11496.137789665976;11601.825972610586;11902.523899043941;11246.550137994389;11296.43517824089;11385.544578216779;11511.942440287745;11909.702257443632 12:32:50 INFO - PROCESS | 14988 | __end_tp_report 12:32:50 INFO - PROCESS | 14988 | __start_cc_report 12:32:50 INFO - PROCESS | 14988 | _x_x_mozilla_cycle_collect,975 12:32:50 INFO - PROCESS | 14988 | __end_cc_report 12:32:50 INFO - PROCESS | 14988 | __startTimestamp1466105569986__endTimestamp 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | ------- Summary: start ------- 12:32:50 INFO - PROCESS | 14988 | Number of tests: 6 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | [#0] dojo.html Cycles:165 Average:5248.46 Median:5465.32 stddev:597.09 (10.9%) stddev-sans-first:573.63 12:32:50 INFO - PROCESS | 14988 | Values: 3056.7 3065.2 3089.9 3102.9 3127.6 5134.3 5190.8 5239.9 5295.8 5312.7 5175.1 5231.0 5320.3 5348.3 5395.7 4597.4 4613.8 4703.8 4759.8 4856.3 4764.8 4829.8 4829.9 4832.1 4844.3 4658.9 4695.7 4712.1 4755.2 4815.9 4729.7 4729.8 4739.6 4805.9 4836.5 4748.6 4765.6 4771.8 4779.0 4816.2 5167.1 5206.2 5249.5 5273.3 5298.7 5583.3 5650.9 5659.1 5663.2 5667.9 5717.5 5727.9 5737.8 5738.6 5739.0 5197.4 5257.2 5312.4 5316.0 5402.1 5854.2 5862.8 5866.1 5868.4 5873.1 5389.9 5649.4 5657.2 5661.7 5664.4 5529.1 5571.7 5592.9 5595.0 5595.8 5518.5 5590.1 5602.6 5609.7 5609.9 5545.2 5563.1 5570.4 5604.5 5619.5 4351.1 4359.5 4392.0 4398.9 4399.1 3870.1 3871.4 3872.5 3893.5 3906.3 5225.6 5277.1 5358.2 5370.2 5416.5 5632.5 5633.4 5641.3 5752.5 5758.3 5423.7 5438.9 5443.4 5444.3 5446.8 4715.4 4777.9 4867.1 4867.2 4918.2 5803.2 5868.6 5871.8 5872.4 5927.0 5644.8 5645.1 5706.5 5709.1 5728.1 5480.2 5543.6 5702.7 5775.6 5803.9 5625.8 5644.1 5655.2 5656.8 5704.2 5636.7 5680.3 5704.1 5730.4 5738.5 5257.1 5465.3 5532.0 5544.0 5552.8 5549.3 5564.9 5569.2 5577.7 5578.7 5501.9 5503.1 5504.8 5508.2 5550.1 5416.9 5484.0 5550.9 5554.2 5632.4 5449.9 5459.5 5461.2 5464.8 5472.4 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | [#1] ext.html Cycles:180 Average:57714.32 Median:39789.90 stddev:114333.42 (287.3%) stddev-sans-first:114573.72 12:32:50 INFO - PROCESS | 14988 | Values: 595.7 613.8 619.1 638.4 638.7 30601.5 31275.4 33437.2 33449.7 33497.8 33377.0 42917.8 43581.0 43593.8 47801.3 8699.3 8880.3 8883.0 8887.1 8891.8 8819.6 8917.8 8920.0 8960.8 8991.5 8971.8 8985.4 8989.3 9002.3 9011.1 8879.1 8902.6 8917.6 8929.1 8932.6 8769.9 8873.6 8880.9 8880.9 8883.6 41673.8 41912.6 41979.0 41981.8 42080.3 3487.6 3581.7 3604.4 3630.1 4018.3 32348.7 32648.3 32927.0 32928.7 33881.8 4316.5 4432.5 4487.0 4525.1 4570.1 326848.0 330964.0 332575.0 333961.0 334163.0 56124.0 56179.0 56345.7 56355.0 56496.4 61138.7 61296.0 61384.4 61400.0 61445.7 16227.5 16498.9 16503.3 16509.7 16510.4 12382.4 12432.4 12442.8 12475.6 12476.4 16632.1 18875.6 18965.3 18970.7 19007.6 5968.1 6742.4 7220.0 7262.2 7335.7 988.8 1006.7 1122.6 1129.0 1198.4 28762.0 30972.8 31621.7 31772.1 31834.8 1075.9 1090.7 1138.0 1146.2 1177.0 15813.8 16061.2 16184.9 16219.8 16328.4 524785.0 526644.0 530325.0 530688.0 532718.0 55417.7 55775.4 55831.7 55853.2 55907.0 1254.6 1314.9 1357.5 1383.3 1398.6 30833.5 32177.2 32235.0 32278.8 32497.2 47061.8 47700.0 47712.3 47745.8 47751.8 400978.0 407720.0 411083.0 411657.0 414376.0 24388.0 25021.5 25030.6 26305.1 26534.5 42447.4 45632.0 45685.8 46186.8 46448.5 38469.8 38774.4 39378.6 39721.0 39858.8 38799.4 38861.6 39656.4 39657.6 40358.0 35177.1 35229.6 35309.5 35342.0 39969.4 32736.3 34848.3 35675.3 35817.6 35885.6 25869.2 26300.5 26368.9 26473.7 26821.7 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | [#2] jquery.html Cycles:180 Average:29119.29 Median:40483.90 stddev:82805.77 (204.5%) stddev-sans-first:83009.89 12:32:50 INFO - PROCESS | 14988 | Values: 351.2 364.5 367.8 373.3 389.3 19308.5 19423.2 19895.7 20212.0 20261.3 19060.0 19160.9 19178.0 19476.5 19626.3 5329.5 5469.5 5659.1 5712.5 5713.3 5521.0 5633.4 5638.6 5651.7 5656.5 5642.5 5644.0 5644.7 5697.2 6287.2 6201.1 6247.6 6251.3 6298.7 6306.3 5412.7 5468.4 5556.3 5557.1 5557.4 12869.7 13017.5 13047.9 16137.0 22691.3 2269.5 2286.6 2437.7 2731.6 2868.7 8895.6 9336.5 9626.2 9834.4 10163.5 1970.0 1997.7 2007.5 2017.4 2100.7 79624.6 81517.0 82853.6 84026.0 84042.0 10382.1 10414.9 10424.9 10611.4 10629.3 14310.4 14415.9 14426.0 14438.6 14459.3 7919.1 8129.6 8140.5 8174.7 8288.3 7221.2 7333.2 7463.7 7538.6 8052.7 4157.6 4295.8 4468.8 4616.1 4631.7 1791.3 1885.8 1894.7 1910.9 1916.2 874.5 922.9 1006.5 1011.5 1019.3 18074.8 18778.9 19385.3 19462.7 19631.0 971.2 975.4 977.1 1013.6 1039.8 10213.6 10693.1 10760.9 10770.2 10810.2 492134.0 496001.0 506085.0 506963.0 509992.0 88822.1 89635.0 91066.0 91331.5 91465.5 905.2 929.7 966.1 972.4 983.6 16479.7 16700.8 17108.3 17171.6 17413.6 40442.0 40525.8 41260.6 42130.9 42438.0 58503.4 59601.0 60091.9 61018.4 61694.4 8342.9 8362.5 8362.6 8381.2 8574.3 9519.0 12881.2 13205.2 13582.1 13857.6 11381.5 12012.5 12058.8 12207.5 12208.9 10992.8 11705.8 11739.6 11796.2 11815.4 12005.7 12017.1 12227.8 12355.4 12464.6 8277.0 8310.3 8520.8 8527.5 8708.8 11006.4 11956.8 12235.6 12350.3 12376.1 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | [#3] mootools.html Cycles:180 Average:5959.10 Median:4529.76 stddev:3457.35 (76.3%) stddev-sans-first:3449.29 12:32:50 INFO - PROCESS | 14988 | Values: 1296.2 1455.9 1459.5 1587.4 1753.5 8481.8 8807.7 8812.4 9133.0 9136.9 8801.2 9046.1 9047.5 9052.3 9065.0 2325.3 2360.1 2360.3 2360.4 2364.0 2313.8 2318.8 2353.1 2353.4 2355.1 2271.6 2303.9 2313.1 2337.5 2337.6 2247.4 2251.7 2256.4 2256.9 2259.2 2222.3 2228.7 2233.1 2234.1 2239.9 8995.1 9092.0 9173.6 9182.0 9291.9 5217.2 5366.6 5377.5 5390.4 5403.5 3365.3 3380.4 3442.6 3460.0 3491.1 1139.8 1176.6 1183.6 1189.3 1202.9 12997.8 13167.1 13177.9 13180.3 13208.9 4436.8 4558.3 4567.4 4579.0 4636.2 10008.8 10019.3 10022.7 10022.9 10042.2 5122.5 5145.4 5181.8 5199.6 5247.9 4013.9 4092.2 4207.6 4635.4 4829.3 3574.8 3622.5 3647.0 3665.9 3732.9 1103.7 1115.4 1119.5 1133.8 1146.2 925.5 983.6 999.2 1021.6 1023.2 6128.3 6206.7 6264.1 6464.9 6575.3 962.5 964.1 977.9 1000.6 1014.4 4297.3 4474.8 4527.4 4532.2 4571.8 11398.8 11723.6 11788.1 11815.9 11824.5 10232.9 10598.7 10617.7 10959.0 10976.5 8466.7 8616.4 8686.5 8687.8 8699.8 6294.5 6510.2 6531.8 6615.6 6663.2 10472.7 10654.5 10835.6 10918.9 10931.2 10503.4 10885.9 10891.6 11030.9 11037.3 7120.4 7696.4 7912.8 8097.0 8264.8 8309.5 8328.4 8363.0 8397.3 8397.7 7788.1 7928.9 7946.3 8089.9 8106.3 7472.0 7612.7 7715.0 7828.5 7841.0 7405.6 7445.9 7622.7 7629.4 7630.4 5436.2 5621.5 5634.9 5656.2 5717.4 5398.9 5458.9 5473.7 5575.5 5850.2 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | [#4] prototype.html Cycles:180 Average:4616.45 Median:5297.39 stddev:1379.63 (26.0%) stddev-sans-first:1344.75 12:32:50 INFO - PROCESS | 14988 | Values: 290.7 304.6 306.3 308.2 315.3 5145.4 5282.6 5331.3 5375.4 5376.3 5275.3 5311.9 5323.6 5324.3 5368.5 4171.7 4184.3 4187.1 4199.1 4205.4 3862.6 3962.2 4070.2 4183.4 4211.2 4077.1 4103.9 4111.8 4122.8 4124.9 4113.6 4119.4 4123.5 4136.9 4139.4 3394.6 3650.6 3651.0 3664.9 3675.6 5140.7 5149.6 5159.1 5197.8 5206.3 4620.6 4627.4 4638.8 4673.3 4702.8 5236.7 5470.9 5505.8 5508.9 5514.3 3799.7 3815.4 3817.9 3848.1 3849.3 5678.4 5732.8 5732.9 5735.7 5780.5 3836.8 3932.8 3949.8 3973.2 3974.7 3942.5 3959.2 3987.6 3992.7 3993.6 4567.4 4573.2 4586.7 4621.8 4639.8 5269.3 5488.8 5495.6 5569.3 5591.5 1277.6 1301.1 1304.8 1304.9 1326.3 869.4 883.5 886.4 898.7 903.3 4660.9 4788.0 4813.1 4821.6 4842.4 5034.8 5048.0 5110.6 5282.9 5708.7 5344.6 5436.5 5444.3 5457.2 5458.5 3042.5 3044.2 3061.0 3061.2 3063.2 5778.9 5913.5 5929.3 5933.3 5941.8 5804.3 5827.9 5853.4 5884.9 5895.9 5590.6 5804.2 5805.0 5898.1 5949.5 5625.9 5630.3 5639.7 5674.5 5686.7 5569.9 5646.3 5676.7 5677.7 5681.4 5623.0 5737.6 5806.6 5813.4 5816.7 3892.7 3894.5 3914.6 3938.3 3945.2 5613.2 5639.5 5643.3 5724.6 5736.7 5225.3 5567.6 5586.8 5590.0 5597.6 5368.6 5559.2 5565.9 5577.7 5579.4 5312.2 5438.2 5480.4 5484.3 5489.6 5493.4 5524.9 5559.6 5578.5 5586.2 5230.8 5410.3 5455.5 5485.4 5497.2 12:32:50 INFO - PROCESS | 14988 | 12:32:50 INFO - PROCESS | 14988 | [#5] yui.html Cycles:180 Average:20546.00 Median:4008.10 stddev:29376.28 (732.9%) stddev-sans-first:29420.95 12:32:50 INFO - PROCESS | 14988 | Values: 716.9 814.5 815.5 824.8 831.9 14598.7 15747.6 15784.0 15791.0 16124.5 15076.5 15109.8 15148.5 15164.6 15234.7 747.7 775.0 777.7 779.0 779.0 765.9 774.0 774.1 774.5 774.6 814.8 815.5 815.8 816.4 816.4 804.5 812.5 813.4 814.1 814.6 591.0 592.0 592.2 592.7 592.9 15697.3 15748.2 15752.3 15754.1 15799.1 13448.1 14176.8 14418.8 14425.2 14446.5 12234.5 12302.4 12499.1 12577.1 12611.8 3833.1 3895.6 3969.7 4046.5 4050.8 73094.6 74004.3 74186.6 75061.6 76557.0 10919.0 11401.5 11486.9 11537.8 11619.6 20872.6 20931.6 21025.6 21063.2 21078.2 8051.2 8139.1 8144.2 8176.6 8262.3 4487.7 4597.1 4693.7 4757.3 4873.9 3486.2 3597.6 3598.2 3598.4 3598.5 607.6 618.5 632.8 634.3 641.0 625.3 702.3 723.0 742.8 785.6 9711.5 9925.2 9933.9 10375.4 10518.1 650.3 652.2 716.2 722.5 725.3 4736.1 4909.7 4920.5 4929.0 4964.0 114623.4 116847.0 117794.4 120486.4 120865.0 66056.0 83768.6 95996.0 100357.0 100605.0 88237.0 90467.0 92036.1 92407.5 93136.0 9881.2 10131.2 10142.4 10226.5 10278.5 50621.0 50693.5 51531.7 51903.0 52078.2 45698.3 64710.0 66447.0 66536.0 76113.0 12637.5 13273.5 13315.9 13400.3 13431.8 14967.9 15045.4 15099.4 15342.3 15966.9 14365.7 14458.8 14601.9 14801.6 15108.6 13430.2 13460.0 13602.1 13752.9 14008.2 13075.0 13503.2 13619.7 13802.9 14023.5 11392.8 11471.4 11496.1 11601.8 11902.5 11246.6 11296.4 11385.5 11511.9 11909.7 12:32:50 INFO - PROCESS | 14988 | -------- Summary: end -------- 12:32:50 INFO - PROCESS | 14988 | 12:32:51 INFO - TEST-INFO | 14988: exit 0 12:32:51 INFO - TEST-OK | dromaeo_css | took 1127563ms 12:32:51 INFO - TEST-START | kraken 12:32:51 INFO - operating with platform_type : linux_ 12:32:51 INFO - Initialising browser for kraken test... 12:32:51 INFO - TEST-INFO | started process 15174 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFsf6UP/profile http://localhost:59119/getInfo.html) 12:32:57 INFO - PROCESS | 15174 | __metrics Screen width/height:1600/1200 12:32:57 INFO - PROCESS | 15174 | colorDepth:24 12:32:57 INFO - PROCESS | 15174 | Browser inner width/height: 1024/697 12:32:57 INFO - PROCESS | 15174 | __metrics 12:32:59 INFO - PROCESS | 15174 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:32:59 INFO - PROCESS | 15174 | console.error: PushService: 12:32:59 INFO - PROCESS | 15174 | stateChangeProcessEnqueue: Error transitioning state 12:32:59 INFO - PROCESS | 15174 | UnknownError 12:33:00 INFO - TEST-INFO | 15174: exit 0 12:33:00 INFO - Browser initialized. 12:33:00 INFO - Running cycle 1/1 for kraken test... 12:33:00 INFO - TEST-INFO | started process 15257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFsf6UP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:12 INFO - PROCESS | 15257 | RSS: Main: 173490176 12:33:12 INFO - PROCESS | 15257 | 12:33:15 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59119/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:15 INFO - PROCESS | 15257 | RSS: Main: 233275392 12:33:15 INFO - PROCESS | 15257 | 12:33:18 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59119/tests/kraken/driver.html?testName=audio-dft) 12:33:19 INFO - PROCESS | 15257 | RSS: Main: 220626944 12:33:19 INFO - PROCESS | 15257 | 12:33:22 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59119/tests/kraken/driver.html?testName=audio-fft) 12:33:23 INFO - PROCESS | 15257 | RSS: Main: 287465472 12:33:23 INFO - PROCESS | 15257 | 12:33:25 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59119/tests/kraken/driver.html?testName=audio-oscillator) 12:33:25 INFO - PROCESS | 15257 | RSS: Main: 197816320 12:33:25 INFO - PROCESS | 15257 | 12:33:27 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:33:28 INFO - PROCESS | 15257 | RSS: Main: 201793536 12:33:28 INFO - PROCESS | 15257 | 12:33:31 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59119/tests/kraken/driver.html?testName=imaging-darkroom) 12:33:32 INFO - PROCESS | 15257 | RSS: Main: 238202880 12:33:32 INFO - PROCESS | 15257 | 12:33:35 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59119/tests/kraken/driver.html?testName=imaging-desaturate) 12:33:36 INFO - PROCESS | 15257 | RSS: Main: 238530560 12:33:36 INFO - PROCESS | 15257 | 12:33:38 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59119/tests/kraken/driver.html?testName=json-parse-financial) 12:33:39 INFO - PROCESS | 15257 | RSS: Main: 238428160 12:33:39 INFO - PROCESS | 15257 | 12:33:40 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:33:41 INFO - PROCESS | 15257 | RSS: Main: 225767424 12:33:41 INFO - PROCESS | 15257 | 12:33:43 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:33:43 INFO - PROCESS | 15257 | RSS: Main: 230219776 12:33:43 INFO - PROCESS | 15257 | 12:33:46 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:33:46 INFO - PROCESS | 15257 | RSS: Main: 239091712 12:33:46 INFO - PROCESS | 15257 | 12:33:49 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:33:49 INFO - PROCESS | 15257 | RSS: Main: 240353280 12:33:49 INFO - PROCESS | 15257 | 12:33:52 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:33:53 INFO - PROCESS | 15257 | RSS: Main: 239927296 12:33:53 INFO - PROCESS | 15257 | 12:33:54 INFO - PROCESS | 15257 | Cycle 1(1): loaded http://localhost:59119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59119/tests/kraken/driver.html?testName=ai-astar) 12:33:55 INFO - PROCESS | 15257 | RSS: Main: 282615808 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | __start_tp_report 12:33:55 INFO - PROCESS | 15257 | _x_x_mozilla_page_load 12:33:55 INFO - PROCESS | 15257 | _x_x_mozilla_page_load_details 12:33:55 INFO - PROCESS | 15257 | |i|pagename|runs| 12:33:55 INFO - PROCESS | 15257 | |0;ai-astar;109;103;108;109;109;109;109;109;107;109 12:33:55 INFO - PROCESS | 15257 | |1;audio-beat-detection;148;127;130;178;130;128;151;128;165;126 12:33:55 INFO - PROCESS | 15257 | |2;audio-dft;160;161;160;159;160;162;161;161;162;160 12:33:55 INFO - PROCESS | 15257 | |3;audio-fft;75;74;75;127;74;75;75;74;101;75 12:33:55 INFO - PROCESS | 15257 | |4;audio-oscillator;85;86;119;86;85;86;116;84;84;128 12:33:55 INFO - PROCESS | 15257 | |5;imaging-gaussian-blur;116;117;116;117;117;117;116;117;117;117 12:33:55 INFO - PROCESS | 15257 | |6;imaging-darkroom;145;146;146;145;146;145;146;146;146;145 12:33:55 INFO - PROCESS | 15257 | |7;imaging-desaturate;96;95;96;95;95;95;96;95;95;95 12:33:55 INFO - PROCESS | 15257 | |8;json-parse-financial;52;53;53;53;54;53;53;53;52;62 12:33:55 INFO - PROCESS | 15257 | |9;json-stringify-tinderbox;61;61;61;62;62;61;61;61;61;61 12:33:55 INFO - PROCESS | 15257 | |10;stanford-crypto-aes;80;80;79;84;80;80;80;88;110;83 12:33:55 INFO - PROCESS | 15257 | |11;stanford-crypto-ccm;126;134;133;122;126;120;130;125;125;133 12:33:55 INFO - PROCESS | 15257 | |12;stanford-crypto-pbkdf2;165;169;160;161;161;163;161;162;166;164 12:33:55 INFO - PROCESS | 15257 | |13;stanford-crypto-sha256-iterative;62;64;64;63;64;64;63;62;62;61 12:33:55 INFO - PROCESS | 15257 | __end_tp_report 12:33:55 INFO - PROCESS | 15257 | __start_cc_report 12:33:55 INFO - PROCESS | 15257 | _x_x_mozilla_cycle_collect,1637 12:33:55 INFO - PROCESS | 15257 | __end_cc_report 12:33:55 INFO - PROCESS | 15257 | __startTimestamp1466105635095__endTimestamp 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | ------- Summary: start ------- 12:33:55 INFO - PROCESS | 15257 | Number of tests: 14 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:1.91 (1.8%) stddev-sans-first:2.00 12:33:55 INFO - PROCESS | 15257 | Values: 109.0 103.0 108.0 109.0 109.0 109.0 109.0 109.0 107.0 109.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:139.00 stddev:18.54 (13.3%) stddev-sans-first:19.50 12:33:55 INFO - PROCESS | 15257 | Values: 148.0 127.0 130.0 178.0 130.0 128.0 151.0 128.0 165.0 126.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 12:33:55 INFO - PROCESS | 15257 | Values: 160.0 161.0 160.0 159.0 160.0 162.0 161.0 161.0 162.0 160.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#3] audio-fft Cycles:10 Average:82.50 Median:75.00 stddev:17.70 (23.6%) stddev-sans-first:18.57 12:33:55 INFO - PROCESS | 15257 | Values: 75.0 74.0 75.0 127.0 74.0 75.0 75.0 74.0 101.0 75.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.58 (20.7%) stddev-sans-first:18.20 12:33:55 INFO - PROCESS | 15257 | Values: 85.0 86.0 119.0 86.0 85.0 86.0 116.0 84.0 84.0 128.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 12:33:55 INFO - PROCESS | 15257 | Values: 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 12:33:55 INFO - PROCESS | 15257 | Values: 145.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 12:33:55 INFO - PROCESS | 15257 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:53.00 stddev:2.94 (5.5%) stddev-sans-first:3.04 12:33:55 INFO - PROCESS | 15257 | Values: 52.0 53.0 53.0 53.0 54.0 53.0 53.0 53.0 52.0 62.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 12:33:55 INFO - PROCESS | 15257 | Values: 61.0 61.0 61.0 62.0 62.0 61.0 61.0 61.0 61.0 61.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:80.00 stddev:9.41 (11.8%) stddev-sans-first:9.84 12:33:55 INFO - PROCESS | 15257 | Values: 80.0 80.0 79.0 84.0 80.0 80.0 80.0 88.0 110.0 83.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:128.00 stddev:4.86 (3.8%) stddev-sans-first:5.13 12:33:55 INFO - PROCESS | 15257 | Values: 126.0 134.0 133.0 122.0 126.0 120.0 130.0 125.0 125.0 133.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:163.50 stddev:2.82 (1.7%) stddev-sans-first:2.92 12:33:55 INFO - PROCESS | 15257 | Values: 165.0 169.0 160.0 161.0 161.0 163.0 161.0 162.0 166.0 164.0 12:33:55 INFO - PROCESS | 15257 | 12:33:55 INFO - PROCESS | 15257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:1.10 (1.7%) stddev-sans-first:1.12 12:33:55 INFO - PROCESS | 15257 | Values: 62.0 64.0 64.0 63.0 64.0 64.0 63.0 62.0 62.0 61.0 12:33:55 INFO - PROCESS | 15257 | -------- Summary: end -------- 12:33:55 INFO - PROCESS | 15257 | 12:33:56 INFO - TEST-INFO | 15257: exit 0 12:33:56 INFO - TEST-OK | kraken | took 65431ms 12:33:56 INFO - SUITE-END | took 1192s 12:33:56 INFO - Completed test suite (00:19:53) 12:33:56 INFO - javascript benchmark 12:33:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3056.694330566944, 3065.187725252807, 3089.8918537851173, 3102.906912792614, 3127.577777000104, 5134.332536770215, 5190.766415511302, 5239.947600523994, 5295.788168473261, 5312.681239125655, 5175.068487672217, 5231.0, 5320.255164277004, 5348.331458567679, 5395.73021348933, 4597.356370108188, 4613.769311534418, 4703.835365762199, 4759.833405830796, 4856.344393506884, 4764.761761911908, 4829.830955916544, 4829.855104346875, 4832.057748738997, 4844.2733589961435, 4658.883527911796, 4695.741734204617, 4712.128256272566, 4755.239161734106, 4815.927761083586, 4729.692569982974, 4729.787159577827, 4739.597134243559, 4805.879853003668, 4836.492168322311, 4748.596369308613, 4765.594924431428, 4771.8091276348905, 4778.976105119487, 4816.229403295491, 5167.0957582422925, 5206.193040078794, 5249.47505249472, 5273.2617433559335, 5298.735063246861, 5583.274174357348, 5650.886982260373, 5659.066254068074, 5663.207150998864, 5667.886642267132, 5717.48542631161, 5727.914081288784, 5737.799177028825, 5738.626989245728, 5738.971305143447, 5197.402298735656, 5257.185136303879, 5312.389075256357, 5316.016536940679, 5402.108652072364, 5854.151148083504, 5862.794802181903, 5866.149408335853, 5868.413158684183, 5873.148393483007, 5389.946100538945, 5649.350324712628, 5657.179708942181, 5661.716914154275, 5664.376918538957, 5529.115341545334, 5571.749271282721, 5592.860178495489, 5595.0, 5595.804146854841, 5518.53092487135, 5590.105583106765, 5602.579806514527, 5609.691466969274, 5609.915851262234, 5545.223668686387, 5563.109902415594, 5570.41510641385, 5604.467575580314, 5619.494245517923, 4351.086271882877, 4359.498657654411, 4392.011797345572, 4398.912021759547, 4399.098184872094, 3870.0518372998795, 3871.380579107329, 3872.457855900176, 3893.5327760668333, 3906.257811015898, 5225.608079394061, 5277.129273669878, 5358.19627055937, 5370.167624018283, 5416.458354164552, 5632.52123569493, 5633.380328163898, 5641.26663533738, 5752.539796816244, 5758.309002919593, 5423.701696406735, 5438.91841622376, 5443.42844001382, 5444.3194600674915, 5446.809361672323, 4715.434147902273, 4777.856664300077, 4867.075255701406, 4867.172580661296, 4918.163912134945, 5803.158542011469, 5868.589198756132, 5871.825634873043, 5872.354041055481, 5926.970365148233, 5644.8024319148635, 5645.096784514458, 5706.514946229451, 5709.058005429058, 5728.140778883034, 5480.232767412645, 5543.584231182758, 5702.657840529581, 5775.624584402, 5803.854903627274, 5625.774969001194, 5644.068728659725, 5655.179998900218, 5656.8020119295625, 5704.172894930129, 5636.661800291996, 5680.289963754531, 5704.144378343116, 5730.369659337553, 5738.48353648157, 5257.053730328577, 5465.316835395575, 5531.9723401382735, 5544.029794785815, 5552.750126244409, 5549.334079910275, 5564.91652625219, 5569.220309156803, 5577.721113944368, 5578.748956297058, 5501.862453438696, 5503.147012213113, 5504.834854954358, 5508.20131080983, 5550.111982082847, 5416.945830541802, 5484.040292948798, 5550.916736248879, 5554.222408862844, 5632.436756324335, 5449.918251226314, 5459.508644222039, 5461.208124821958, 5464.754086066216, 5472.425395333433], "value": 5208.490450343116, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [595.7259660556144, 613.806650904965, 619.0806652121596, 638.4126603524757, 638.7221558621999, 30601.540976885335, 31275.374492510135, 33437.16407089824, 33449.66550334496, 33497.83251083741, 33377.0, 42917.7854110729, 43581.0, 43593.7820310898, 47801.28298075531, 8699.260562852165, 8880.333974951873, 8882.955585222066, 8887.066857979917, 8891.822163556724, 8819.603117859711, 8917.821643567126, 8920.0, 8960.775980600472, 8991.505467199302, 8971.775705607346, 8985.415947963395, 8989.325800564951, 9002.279817614608, 9011.053839346872, 8879.112088791102, 8902.599383027778, 8917.643294268222, 8929.107089291052, 8932.55337233139, 8769.912300876973, 8873.645054197825, 8880.8667869982, 8880.911190888073, 8883.644654213824, 41673.79163104195, 41912.580874191175, 41979.0, 41981.79009104935, 42080.31678732847, 3487.5814902211896, 3581.7313701472235, 3604.42329227325, 3630.110622897381, 4018.3168861293357, 32348.6765132348, 32648.347033059443, 32927.0, 32928.6707132928, 33881.83059084714, 4316.48202215733, 4432.490263619693, 4486.977565112154, 4525.094981003813, 4570.131674981776, 326848.0, 330964.0, 332575.0, 333961.0, 334162.99999999756, 56124.0, 56179.0, 56345.71827140838, 56355.0, 56496.43503564994, 61138.69430652818, 61296.0, 61384.38615613876, 61400.0, 61445.692771535854, 16227.513174604781, 16498.917505412395, 16503.257353418885, 16509.6698066038, 16510.42213522521, 12382.442790074469, 12432.37838108091, 12442.81335779964, 12475.625731228078, 12476.438560264809, 16632.128054880603, 18875.622487550172, 18965.33621323247, 18970.71543926842, 19007.61984760297, 5968.121400420582, 6742.359475849787, 7219.963900180465, 7262.164851042197, 7335.7432489862595, 988.8467287570438, 1006.7231511334442, 1122.5678113926033, 1128.9887101129048, 1198.4487135917575, 28762.0, 30972.845135774176, 31621.683783162334, 31772.109573454207, 31834.840825796186, 1075.8816530181673, 1090.7055095124272, 1137.9601713939971, 1146.2320245435578, 1177.0289511153333, 15813.841861581466, 16061.196940152946, 16184.919075404548, 16219.837801622069, 16328.428505002268, 524785.0, 526644.0, 530325.0, 530688.0, 532718.0, 55417.722911385186, 55775.44224557783, 55831.72084139553, 55853.16220256699, 55907.0, 1254.5985284708806, 1314.9013823963242, 1357.4773712120707, 1383.3498255819748, 1398.6433459467567, 30833.537496937115, 32177.195570110933, 32235.0, 32278.83860580682, 32497.187570310933, 47061.76469117632, 47700.0, 47712.28431573599, 47745.76127119342, 47751.76124119357, 400978.0, 407720.0, 411083.0, 411657.0, 414376.0, 24388.0, 25021.499570008862, 25030.62454063154, 26305.079322224396, 26534.469310614066, 42447.36328955006, 45632.0, 45685.77157114193, 46186.769066154455, 46448.53551464442, 38469.807650961564, 38774.364959153325, 39378.60621393749, 39721.0, 39858.800705996284, 38799.418008730456, 38861.6113838858, 39656.40515392214, 39657.603423966546, 40358.0, 35177.120571985906, 35229.647703522634, 35309.47035794517, 35342.0, 39969.40045899255, 32736.345273093928, 34848.303033938675, 35675.28649427049, 35817.64182358143, 35885.64114358927, 25869.22392328233, 26300.4739905197, 26368.945242190865, 26473.735262647126, 26821.731782682706], "value": 19530.572302373646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1537195359184, 364.54249916354973, 367.8436664417622, 373.2777076357249, 389.29343242015756, 19308.51728706783, 19423.22307107716, 19895.701564476545, 20212.0, 20261.2908548201, 19060.0, 19160.904195479005, 19178.0, 19476.51308717283, 19626.313079042236, 5329.467053294678, 5469.480399362064, 5659.066254068094, 5712.457316554942, 5713.257276554042, 5521.033819081665, 5633.436656334355, 5638.605297629168, 5651.717414129298, 5656.547476201894, 5642.548596112321, 5643.971780141093, 5644.74598643062, 5697.230873832021, 6287.151234583318, 6201.100840378165, 6247.625142491465, 6251.3123556408755, 6298.653574053448, 6306.337834527378, 5412.702301373423, 5468.425815289417, 5556.333240011184, 5557.055300598908, 5557.360903496109, 12869.67825804353, 13017.479300827956, 13047.869521304856, 16137.0, 22691.319260422213, 2269.4893648929024, 2286.576983258086, 2437.695288088989, 2731.5902614607967, 2868.7131286871354, 8895.644174233023, 9336.533173341306, 9626.229901607854, 9834.409935403899, 10163.4918254087, 1969.9704504432302, 1997.6550557295345, 2007.4880905369037, 2017.3947815655392, 2100.705901173837, 79624.60187699083, 81517.0, 82853.58573207156, 84026.0, 84042.0, 10382.117520010883, 10414.917016596712, 10424.895751042393, 10611.363318200933, 10629.30909490896, 14310.427582896567, 14415.927920360331, 14426.0, 14438.639034024023, 14459.27703614815, 7919.128895821455, 8129.634166462523, 8140.511569305861, 8174.651182554812, 8288.336933045342, 7221.205667376585, 7333.1566869809585, 7463.738769143162, 7538.585377804164, 8052.718154864551, 4157.605027522381, 4295.806688698954, 4468.843590474317, 4616.1229366420275, 4631.745254011062, 1791.3372052340717, 1885.8019907909472, 1894.6779047561672, 1910.866239363259, 1916.2430839818194, 874.5408660453186, 922.9123233292827, 1006.5017816181037, 1011.5144730529387, 1019.2814066083394, 18074.819251807312, 18778.906105469385, 19385.321513746952, 19462.70805937912, 19631.0, 971.1696499492832, 975.4050029482011, 977.1449981266392, 1013.6046941692746, 1039.8024375368657, 10213.642522511676, 10693.091087257515, 10760.946195268974, 10770.192235582363, 10810.243282970117, 492134.0, 496001.0, 506085.0, 506963.0, 509992.0, 88822.11177888268, 89635.0, 91066.0, 91331.54334228286, 91465.54267228622, 905.2079430498445, 929.7164364868645, 966.0966995858895, 972.4019727867311, 983.6213057972589, 16479.670406592042, 16700.83299166993, 17108.315667373663, 17171.57071073183, 17413.564660883578, 40442.0, 40525.79737101296, 41260.58739412567, 42130.946726332084, 42438.0, 58503.4149658515, 59601.0, 60091.898911197335, 61018.389816103045, 61694.38305616887, 8342.916570834213, 8362.498250105013, 8362.581870906308, 8381.203785640355, 8574.31405487572, 9518.95240523793, 12881.162724422882, 13205.20768753878, 13582.117162384413, 13857.584272471842, 11381.54473821071, 12012.510752982202, 12058.758824823279, 12207.450664720287, 12208.938955305166, 10992.835107473555, 11705.765884682089, 11739.589114381297, 11796.233244839059, 11815.40922953866, 12005.699857503283, 12017.09871759604, 12227.816582751087, 12355.3822308886, 12464.626061218178, 8276.958615207126, 8310.252077313071, 8520.829583408173, 8527.488350698977, 8708.825823483621, 11006.394648294421, 11956.760864782482, 12235.632931012084, 12350.258984460961, 12376.07179461526], "value": 9053.15323318975, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.2352212194814, 1455.890808189386, 1459.5037687186357, 1587.4047232287892, 1753.5090174751067, 8481.787955301113, 8807.691730789416, 8812.38313318068, 9132.95433522833, 9136.857892763404, 8801.163889430494, 9046.140616641409, 9047.457152570834, 9052.275817934566, 9064.95467522663, 2325.348902307348, 2360.0559776089617, 2360.280114565057, 2360.433495960974, 2363.9645405318934, 2313.768623137681, 2318.8492747971327, 2353.1175809071597, 2353.352827972304, 2355.0697474497565, 2271.5570463759573, 2303.873286969216, 2313.144136669426, 2337.4857531343077, 2337.5909215887236, 2247.370736193868, 2251.74104977928, 2256.3682168992627, 2256.9210077647285, 2259.2318611672026, 2222.3110835641005, 2228.6768418579377, 2233.129079658934, 2234.1175235781775, 2239.880059970015, 8995.145461181177, 9091.954540227256, 9173.633054677804, 9182.035886231915, 9291.860622090675, 5217.217417387422, 5366.570674346043, 5377.46225377463, 5390.434004429557, 5403.5136837684795, 3365.3437579671972, 3380.408428525023, 3442.621311655716, 3460.0311912664492, 3491.092315997859, 1139.789139009286, 1176.647005898227, 1183.5502509046507, 1189.3220864107461, 1202.9157958942878, 12997.805032924514, 13167.078304518687, 13177.934110329386, 13180.34098295091, 13208.933955330258, 4436.822527098944, 4558.293464513005, 4567.4062371892105, 4579.038401935564, 4636.165490211727, 10008.79982400348, 10019.298649094639, 10022.699319020441, 10022.899771002343, 10042.19662427004, 5122.513361230677, 5145.382554093458, 5181.766820493087, 5199.63602547818, 5247.868803279872, 4013.8795836124964, 4092.2224777292217, 4207.579242075829, 4635.351050852883, 4829.323894654751, 3574.8391322390553, 3622.4747411625167, 3646.9817650911577, 3665.9368783052614, 3732.850685972585, 1103.7406209540752, 1115.4255558387438, 1119.5350390541423, 1133.7675776465805, 1146.220570012383, 925.5372313843078, 983.5868935047297, 999.2305924438142, 1021.5658345203259, 1023.1610079734695, 6128.264608247039, 6206.658633775095, 6264.140765861374, 6464.935350646528, 6575.276719560845, 962.4658314635304, 964.1370972979284, 977.9070988256104, 1000.5697550053546, 1014.4319181258519, 4297.269464191032, 4474.798634061475, 4527.366168736379, 4532.161550113239, 4571.794269257892, 11398.772024559463, 11723.648290551297, 11788.056955443544, 11815.940920295343, 11824.527018919147, 10232.897671023344, 10598.682039538671, 10617.734556636145, 10959.0, 10976.451177441097, 8466.703665371682, 8616.405964896514, 8686.47881127147, 8687.826243475096, 8699.782505437415, 6294.464970477377, 6510.18622672166, 6531.836704082246, 6615.636140012153, 6663.167104111986, 10472.68581942543, 10654.520546575268, 10835.620753273914, 10918.945405272923, 10931.18016148776, 10503.42231177262, 10885.891141088488, 10891.618793342512, 11030.889691103308, 11037.337759734442, 7120.430365570845, 7696.422768292288, 7912.84174316499, 8096.959515202622, 8264.83470330602, 8309.501429914224, 8328.417010809428, 8362.958185209034, 8397.286230670461, 8397.70608028716, 7788.104367997753, 7928.881066784118, 7946.284834364935, 8089.878651820345, 8106.310963568163, 7471.9626401867645, 7612.657430415534, 7715.0, 7828.491148075357, 7841.0, 7405.629718513945, 7445.851082978202, 7622.69509219625, 7629.389648828192, 7630.427717921067, 5436.211749296409, 5621.4659607337235, 5634.943650563442, 5656.236408084856, 5717.37108918027, 5398.946010539844, 5458.863528411822, 5473.72631368422, 5575.498205161555, 5850.151727999501], "value": 4719.869746048603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.6991264041716, 304.61922596754056, 306.33372414997376, 308.2063686008527, 315.28745036218146, 5145.434002259748, 5282.6492210966135, 5331.2536244925695, 5375.4355792641745, 5376.327959005124, 5275.261463395128, 5311.893762124755, 5323.627346085766, 5324.254604355384, 5368.46315368463, 4171.728837625545, 4184.2677531431955, 4187.1416359646355, 4199.076203235283, 4205.369194620801, 3862.633049860259, 3962.2075584882996, 4070.2266569351877, 4183.393407955845, 4211.199872024321, 4077.103037331782, 4103.8563650272245, 4111.7944102794745, 4122.793860306988, 4124.896877578055, 4113.56807535209, 4119.361498967664, 4123.546409894909, 4136.875893723193, 4139.3583994480905, 3394.6096198937194, 3650.5801832789302, 3650.963490365089, 3664.926701465956, 3675.5956844747056, 5140.691558506502, 5149.588032957355, 5159.097157997336, 5197.844064678028, 5206.323177986837, 4620.607248383892, 4627.449804315558, 4638.814447422099, 4673.299005149221, 4702.788374523155, 5236.6857988520815, 5470.91793623096, 5505.807296744635, 5508.944910550883, 5514.338279406497, 3799.696024318048, 3815.389537673959, 3817.8854634361014, 3848.134169811798, 3849.268638958589, 5678.4037676044245, 5732.770689172428, 5732.914006289909, 5735.684537350444, 5780.450857168605, 3836.76979381238, 3932.823022963916, 3949.7827619481204, 3973.2450834341385, 3974.7018973577096, 3942.4677668514955, 3959.1685745993086, 3987.627361719772, 3992.740471869319, 3993.6405723484445, 4567.406237189144, 4573.153966516205, 4586.669865738898, 4621.838235661736, 4639.837605683852, 5269.262303277545, 5488.807891723771, 5495.587830912617, 5569.275994120739, 5591.52472039873, 1277.591170825327, 1301.1412467771415, 1304.7651422743998, 1304.9412776425083, 1326.257295914291, 869.3523325122824, 883.5008220355479, 886.3662481325754, 898.7213963671282, 903.3225081189108, 4660.86017419478, 4788.0, 4813.109574728686, 4821.614270858323, 4842.443119041355, 5034.84895453137, 5048.0, 5110.565601923804, 5282.894342113136, 5708.743106560215, 5344.599155063308, 5436.483534064258, 5444.292242008592, 5457.154141108134, 5458.5087342139395, 3042.5284080967485, 3044.2237229506336, 3060.9540856887165, 3061.219389055821, 3063.218879185838, 5778.88442231153, 5913.497352725067, 5929.288485381781, 5933.258342707161, 5941.792037278675, 5804.303483581997, 5827.921834460638, 5853.414658534112, 5884.882302353929, 5895.882082358415, 5590.552755779528, 5804.245448091721, 5804.984127777622, 5898.144769008555, 5949.464548190597, 5625.915611265752, 5630.296212973379, 5639.746211420414, 5674.546036317167, 5686.687232202268, 5569.888602227852, 5646.2942132233475, 5676.659400435987, 5677.687727175045, 5681.4034526374135, 5623.0, 5737.627054241461, 5806.593538452268, 5813.430373799135, 5816.651000939788, 3892.727509074451, 3894.4547763313726, 3914.6494459411456, 3938.2517321708783, 3945.2109578083923, 5613.186088017296, 5639.548836093185, 5643.266375371176, 5724.624280923536, 5736.71316434185, 5225.268462415341, 5567.633755653912, 5586.804461843979, 5590.043484780294, 5597.552195824405, 5368.57051435892, 5559.221708960829, 5565.944340556543, 5577.693226872561, 5579.401286170479, 5312.229726689686, 5438.2386465894015, 5480.3971563128825, 5484.341878974548, 5489.627593101724, 5493.368262649847, 5524.861878453071, 5559.58303127259, 5578.470045345685, 5586.217929489793, 5230.843074707765, 5410.323709536308, 5455.49973757204, 5485.396606373375, 5497.175423686479], "value": 4163.528826725869, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.9032180655612, 814.474663841822, 815.4740192575789, 824.766854309407, 831.875218717192, 14598.708025839476, 15747.60630984226, 15784.0, 15791.0, 16124.516264512069, 15076.547703568911, 15109.84890151098, 15148.46980355685, 15164.620884477894, 15234.695306093872, 747.7083937264471, 774.9883751743729, 777.6500574741389, 778.9844203115935, 778.9883151752729, 765.8812884002989, 774.0, 774.0827119862952, 774.4694884004475, 774.6088225446142, 814.8411059843332, 815.4536460571431, 815.7715839564902, 816.3713940265992, 816.4325793573469, 804.4770898915693, 812.4840726138885, 813.3574476163853, 814.0922870998853, 814.5764202614637, 590.9970450147765, 591.9526437885002, 592.1591340296789, 592.7214209321612, 592.863641362489, 15697.293621787047, 15748.2125893706, 15752.291146898302, 15754.054756714633, 15799.131047792482, 13448.1258718183, 14176.787348189786, 14418.783718244234, 14425.206613636246, 14446.494372696905, 12234.510619575207, 12302.446389912475, 12499.125061245717, 12577.11960162789, 12611.810822837664, 3833.099221682902, 3895.5520115186832, 3969.702272329587, 4046.4941882264716, 4050.8177132029127, 73094.63452682702, 74004.25995740028, 74186.62906685432, 75061.62469187619, 76557.0, 10919.0, 11401.543938242543, 11486.885131148749, 11537.769244615229, 11619.593314233962, 20872.58254834895, 20931.581368372852, 21025.579488410145, 21063.157473701187, 21078.156873725187, 8051.194880512019, 8139.104698483162, 8144.226298501633, 8176.6320515576945, 8262.297704695167, 4487.730736155841, 4597.149527337453, 4693.718376897397, 4757.26262429324, 4873.853784386474, 3486.18074752433, 3597.5503062117236, 3598.1544337080763, 3598.3882739934274, 3598.4602309653237, 607.6475644126396, 618.4959258204639, 632.7975047984601, 634.280092095475, 641.0416427440913, 625.3402660193449, 702.2731472925498, 722.9530080544748, 742.8217227865273, 785.6386062411241, 9711.514424278757, 9925.2059835213, 9933.850992234979, 10375.429351385596, 10518.142451844078, 650.3366566102549, 652.1522021372197, 716.1656669979519, 722.4653756220359, 725.2521423369759, 4736.076465089274, 4909.68087074339, 4920.458749537548, 4928.950710492921, 4963.950360496421, 114623.42688286673, 116847.0, 117794.41102794431, 120486.39756801336, 120865.0, 66056.0, 83768.58115709382, 95996.0, 100357.0, 100605.0, 88237.0, 90466.99999999869, 92036.07963920276, 92407.53796230975, 93136.0, 9881.209503239867, 10131.189504839742, 10142.391456512632, 10226.539805708611, 10278.537465813906, 50621.0, 50693.49306506888, 51531.74234128805, 51903.0, 52078.218826716875, 45698.31452528148, 64710.02934956073, 66447.0, 66536.0, 76113.0, 12637.494500219887, 13273.469061237442, 13315.933420332836, 13400.32998350098, 13431.798523022358, 14967.925160374129, 15045.362153586571, 15099.39602415935, 15342.309596068428, 15966.920165399564, 14365.712685746017, 14458.783118253024, 14601.85398146005, 14801.555953321418, 15108.622284442978, 13430.19418834834, 13460.0, 13602.115862468909, 13752.862471375558, 14008.159510429407, 13075.0, 13503.189808611514, 13619.727605448034, 13802.93098534541, 14023.50917717875, 11392.770700319717, 11471.4264286787, 11496.137789665976, 11601.825972610586, 11902.523899043941, 11246.550137994389, 11296.43517824089, 11385.544578216779, 11511.942440287745, 11909.702257443632], "value": 7563.454740678024, "unit": "score"}], "name": "dromaeo_css", "value": 7178.9976468747045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 103.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 107.0, 109.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 127.0, 130.0, 178.0, 130.0, 128.0, 151.0, 128.0, 165.0, 126.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 160.0, 159.0, 160.0, 162.0, 161.0, 161.0, 162.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 127.0, 74.0, 75.0, 75.0, 74.0, 101.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 119.0, 86.0, 85.0, 86.0, 116.0, 84.0, 84.0, 128.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 53.0, 53.0, 54.0, 53.0, 53.0, 53.0, 52.0, 62.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 79.0, 84.0, 80.0, 80.0, 80.0, 88.0, 110.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 133.0, 122.0, 126.0, 120.0, 130.0, 125.0, 125.0, 133.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 169.0, 160.0, 161.0, 161.0, 163.0, 161.0, 162.0, 166.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 62.0, 62.0, 61.0], "value": 62.9, "unit": "score"}], "name": "kraken", "value": 1498.7000000000003, "alertThreshold": 2.0}]} 12:33:56 INFO - Return code: 0 12:33:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:33:56 INFO - # TBPL SUCCESS # 12:33:56 INFO - Running post-action listener: _resource_record_post_action 12:33:56 INFO - ##### 12:33:56 INFO - ##### Finished run-tests step (success) 12:33:56 INFO - ##### 12:33:56 INFO - Running post-run listener: _resource_record_post_run 12:33:56 INFO - Total resource usage - Wall time: 1211s; CPU: 14.0%; Read bytes: 0; Write bytes: 555687936; Read time: 0; Write time: 4150208 12:33:56 INFO - TinderboxPrint: CPU usage
13.7% 12:33:56 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:33:56 INFO - TinderboxPrint: I/O write bytes / time
555,687,936 / 4,150,208 12:33:56 INFO - TinderboxPrint: CPU idle
8,341.2 (86.3%) 12:33:56 INFO - TinderboxPrint: CPU user
1,208.7 (12.5%) 12:33:56 INFO - TinderboxPrint: Swap in / out
0 / 0 12:33:56 INFO - install - Wall time: 17s; CPU: 29.0%; Read bytes: 0; Write bytes: 166313984; Read time: 0; Write time: 1321400 12:33:56 INFO - run-tests - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 389373952; Read time: 0; Write time: 2828808 12:33:57 INFO - Running post-run listener: _upload_blobber_files 12:33:57 INFO - Blob upload gear active. 12:33:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:33:57 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 12:33:57 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'] 12:33:57 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 12:33:57 INFO - (blobuploader) - INFO - Open directory for files ... 12:33:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:33:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:33:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:33:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:33:58 INFO - (blobuploader) - INFO - Done attempting. 12:33:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:33:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:33:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:34:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:04 INFO - (blobuploader) - INFO - Done attempting. 12:34:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:06 INFO - (blobuploader) - INFO - Done attempting. 12:34:06 INFO - (blobuploader) - INFO - Iteration through files over. 12:34:06 INFO - Return code: 0 12:34:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:34:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:34:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0f17ef820f5083e3725a698e753dfcf1277c33af00e3301a52bc7b1be523709667d3a3237bea5b121f0621ff3abb560cb182cb96e5d93c81745993732ffe0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1535e604d895891e546201b12cbc525f6227736c837b4cf4261f7c5edf75022907d36adf8fb0c1143a8e93f3b09e2e57fe903942f171c531856578fe89077b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8a2ae363ed7c953e5184daab2c6f460fe6464b3c68703f1115c83705509199dd0cca8a7ddaa15147a77b1ee21c2804ad5ed2637cfd4013989d2f64aa18906"} 12:34:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:34:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:34:06 INFO - Contents: 12:34:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0f17ef820f5083e3725a698e753dfcf1277c33af00e3301a52bc7b1be523709667d3a3237bea5b121f0621ff3abb560cb182cb96e5d93c81745993732ffe0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1535e604d895891e546201b12cbc525f6227736c837b4cf4261f7c5edf75022907d36adf8fb0c1143a8e93f3b09e2e57fe903942f171c531856578fe89077b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8a2ae363ed7c953e5184daab2c6f460fe6464b3c68703f1115c83705509199dd0cca8a7ddaa15147a77b1ee21c2804ad5ed2637cfd4013989d2f64aa18906"} 12:34:06 INFO - Running post-run listener: copy_logs_to_upload_dir 12:34:06 INFO - Copying logs to upload dir... 12:34:06 INFO - mkdir: /builds/slave/test/build/upload/logs 12:34:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.148783 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2016-06-16 12:34:05.801771) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:05.804879) ========= 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=33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195 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/d0f17ef820f5083e3725a698e753dfcf1277c33af00e3301a52bc7b1be523709667d3a3237bea5b121f0621ff3abb560cb182cb96e5d93c81745993732ffe0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1535e604d895891e546201b12cbc525f6227736c837b4cf4261f7c5edf75022907d36adf8fb0c1143a8e93f3b09e2e57fe903942f171c531856578fe89077b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8a2ae363ed7c953e5184daab2c6f460fe6464b3c68703f1115c83705509199dd0cca8a7ddaa15147a77b1ee21c2804ad5ed2637cfd4013989d2f64aa18906"} build_url:https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011445 build_url: 'https://queue.taskcluster.net/v1/task/G1__st0QScSVAvTR6pLqjA/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/d0f17ef820f5083e3725a698e753dfcf1277c33af00e3301a52bc7b1be523709667d3a3237bea5b121f0621ff3abb560cb182cb96e5d93c81745993732ffe0dd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1535e604d895891e546201b12cbc525f6227736c837b4cf4261f7c5edf75022907d36adf8fb0c1143a8e93f3b09e2e57fe903942f171c531856578fe89077b28", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/def8a2ae363ed7c953e5184daab2c6f460fe6464b3c68703f1115c83705509199dd0cca8a7ddaa15147a77b1ee21c2804ad5ed2637cfd4013989d2f64aa18906"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:05.829401) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:05.829706) ========= 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=33d5923976266a1c518c4bf7000001ab-1466101793.646122-1642615195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-16 12:34:05.915337) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:34:05.915659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-16 12:34:05.915942) ========= ========= Total master_lag: 0.18 =========