builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1465420132.68 results: success (0) buildid: 20160608113003 builduid: f603ab7aae8f4a92bb00709089d6c269 revision: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.684172) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.685253) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.685895) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.702395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.703058) ========= 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=7de08804244eb36560b44971000001c3-1465420072.647511-1494502784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 14:08:52-- 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% 70.4M=0s 2016-06-08 14:08:52 (70.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108280 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.832278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.832999) ========= 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=7de08804244eb36560b44971000001c3-1465420072.647511-1494502784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015736 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.887234) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:52.887976) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 --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 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 --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=7de08804244eb36560b44971000001c3-1465420072.647511-1494502784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 14:08:52,911 truncating revision to first 12 chars 2016-06-08 14:08:52,911 Setting DEBUG logging. 2016-06-08 14:08:52,911 attempt 1/10 2016-06-08 14:08:52,911 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62ad4f6b5c34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 14:08:53,195 unpacking tar archive at: fx-team-62ad4f6b5c34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630974 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:53.539097) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:53.539930) ========= script_repo_revision: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:53.540566) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:53.540878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 14:08:53.554225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-08 14:08:53.554547) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7de08804244eb36560b44971000001c3-1465420072.647511-1494502784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:53 INFO - MultiFileLogger online at 20160608 14:08:53 in /builds/slave/test 14:08:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:08:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:53 INFO - {'append_to_log': False, 14:08:53 INFO - 'base_work_dir': '/builds/slave/test', 14:08:53 INFO - 'blob_upload_branch': 'Fx-Team', 14:08:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:53 INFO - 'branch': 'Fx-Team', 14:08:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:53 INFO - 'config_files': ('talos/linux_config.py',), 14:08:53 INFO - 'default_actions': ('clobber', 14:08:53 INFO - 'read-buildbot-config', 14:08:53 INFO - 'download-and-extract', 14:08:53 INFO - 'populate-webroot', 14:08:53 INFO - 'create-virtualenv', 14:08:53 INFO - 'install', 14:08:53 INFO - 'run-tests'), 14:08:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:53 INFO - 'download_minidump_stackwalk': True, 14:08:53 INFO - 'download_symbols': 'ondemand', 14:08:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:53 INFO - 'installer_path': 'installer.exe', 14:08:53 INFO - 'log_level': 'info', 14:08:53 INFO - 'log_name': 'talos', 14:08:53 INFO - 'log_to_console': True, 14:08:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:53 INFO - 'opt_config_files': (), 14:08:53 INFO - 'pip_index': False, 14:08:53 INFO - 'sps_profile': False, 14:08:53 INFO - 'sps_profile_interval': 0, 14:08:53 INFO - 'suite': 'dromaeojs-e10s', 14:08:53 INFO - 'system_bits': '32', 14:08:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:53 INFO - 'title': 'talos-linux64-ix-003', 14:08:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:53 INFO - 'use_talos_json': True, 14:08:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:53 INFO - 'work_dir': 'build'} 14:08:53 INFO - ##### 14:08:53 INFO - ##### Running clobber step. 14:08:53 INFO - ##### 14:08:53 INFO - Running pre-action listener: _resource_record_pre_action 14:08:53 INFO - Running main action method: clobber 14:08:53 INFO - rmtree: /builds/slave/test/build 14:08:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:54 INFO - Running post-action listener: _resource_record_post_action 14:08:54 INFO - ##### 14:08:54 INFO - ##### Finished clobber step (success) 14:08:54 INFO - ##### 14:08:54 INFO - ##### 14:08:54 INFO - ##### Running read-buildbot-config step. 14:08:54 INFO - ##### 14:08:54 INFO - Running pre-action listener: _resource_record_pre_action 14:08:54 INFO - Running main action method: read_buildbot_config 14:08:54 INFO - Using buildbot properties: 14:08:54 INFO - { 14:08:54 INFO - "project": "", 14:08:54 INFO - "product": "firefox", 14:08:54 INFO - "script_repo_revision": "production", 14:08:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:08:54 INFO - "repository": "", 14:08:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:08:54 INFO - "buildid": "20160608113003", 14:08:54 INFO - "pgo_build": "True", 14:08:54 INFO - "basedir": "/builds/slave/test", 14:08:54 INFO - "buildnumber": 441, 14:08:54 INFO - "slavename": "talos-linux64-ix-003", 14:08:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:08:54 INFO - "platform": "ubuntu64_hw", 14:08:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:08:54 INFO - "branch": "fx-team", 14:08:54 INFO - "repo_path": "integration/fx-team", 14:08:54 INFO - "revision": "62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92", 14:08:54 INFO - "stage_platform": "linux64-pgo", 14:08:54 INFO - "builduid": "f603ab7aae8f4a92bb00709089d6c269", 14:08:54 INFO - "slavebuilddir": "test" 14:08:54 INFO - } 14:08:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:08:54 INFO - Running post-action listener: _resource_record_post_action 14:08:54 INFO - ##### 14:08:54 INFO - ##### Finished read-buildbot-config step (success) 14:08:54 INFO - ##### 14:08:54 INFO - ##### 14:08:54 INFO - ##### Running download-and-extract step. 14:08:54 INFO - ##### 14:08:54 INFO - Running pre-action listener: _resource_record_pre_action 14:08:54 INFO - Running main action method: download_and_extract 14:08:54 INFO - mkdir: /builds/slave/test/build/tests 14:08:54 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')]} 14:08:54 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:08:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:08:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:08:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:08:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:08:57 INFO - Downloaded 1361 bytes. 14:08:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:08:57 INFO - Using the following test package requirements: 14:08:57 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:08:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:08:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:08:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'jsshell-linux-x86_64.zip'], 14:08:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:08:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:08:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:08:57 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:08:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:08:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:08:57 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:08:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:08:57 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')]} 14:08:57 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:08:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:08:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:08:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:08:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:08:58 INFO - Downloaded 24451000 bytes. 14:08:58 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'] 14:08:58 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 14:09:00 INFO - Return code: 0 14:09:00 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 14:09:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:00 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:09:04 INFO - Downloaded 24451000 bytes. 14:09:04 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'] 14:09:04 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 14:09:05 INFO - Return code: 0 14:09:05 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')]} 14:09:05 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:09:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:09:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:09:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:09:06 INFO - Downloaded 10833369 bytes. 14:09:06 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'] 14:09:06 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 14:09:07 INFO - Return code: 0 14:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:09:07 INFO - https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/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 14:09:12 INFO - Downloaded 59327853 bytes. 14:09:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:12 INFO - mkdir: /builds/slave/test/properties 14:09:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:12 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:12 INFO - Contents: 14:09:12 INFO - build_url:https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:09:12 INFO - Running post-action listener: _resource_record_post_action 14:09:12 INFO - Running post-action listener: set_extra_try_arguments 14:09:12 INFO - ##### 14:09:12 INFO - ##### Finished download-and-extract step (success) 14:09:12 INFO - ##### 14:09:12 INFO - ##### 14:09:12 INFO - ##### Running populate-webroot step. 14:09:12 INFO - ##### 14:09:12 INFO - Running pre-action listener: _resource_record_pre_action 14:09:12 INFO - Running main action method: populate_webroot 14:09:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:13 INFO - '--tppagecycles', 14:09:13 INFO - '7'], 14:09:13 INFO - 'tests': ['tsvgm']}}, 14:09:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['damp', 'tps']}, 14:09:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'tests': ['damp', 'tps']}, 14:09:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['dromaeo_dom']}, 14:09:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['a11yr', 14:09:13 INFO - 'ts_paint', 14:09:13 INFO - 'tpaint', 14:09:13 INFO - 'sessionrestore', 14:09:13 INFO - 'sessionrestore_no_auto_restore', 14:09:13 INFO - 'tabpaint']}, 14:09:13 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:13 INFO - 'ts_paint', 14:09:13 INFO - 'tpaint', 14:09:13 INFO - 'sessionrestore', 14:09:13 INFO - 'sessionrestore_no_auto_restore', 14:09:13 INFO - 'tabpaint']}, 14:09:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:13 INFO - 'ts_paint', 14:09:13 INFO - 'tpaint', 14:09:13 INFO - 'sessionrestore', 14:09:13 INFO - 'sessionrestore_no_auto_restore', 14:09:13 INFO - 'tabpaint']}, 14:09:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:13 INFO - 'ts_paint', 14:09:13 INFO - 'tpaint', 14:09:13 INFO - 'sessionrestore', 14:09:13 INFO - 'sessionrestore_no_auto_restore', 14:09:13 INFO - 'tabpaint']}, 14:09:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['a11yr', 14:09:13 INFO - 'ts_paint', 14:09:13 INFO - 'tpaint', 14:09:13 INFO - 'sessionrestore', 14:09:13 INFO - 'sessionrestore_no_auto_restore', 14:09:13 INFO - 'tabpaint']}, 14:09:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['a11yr', 14:09:13 INFO - 'ts_paint', 14:09:13 INFO - 'tpaint', 14:09:13 INFO - 'sessionrestore', 14:09:13 INFO - 'sessionrestore_no_auto_restore', 14:09:13 INFO - 'tabpaint']}, 14:09:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['tsvgx', 14:09:13 INFO - 'tsvgr_opacity', 14:09:13 INFO - 'tart', 14:09:13 INFO - 'tscrollx', 14:09:13 INFO - 'cart']}, 14:09:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:13 INFO - 'tsvgr_opacity', 14:09:13 INFO - 'tart', 14:09:13 INFO - 'tscrollx', 14:09:13 INFO - 'cart']}, 14:09:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'talos_options': ['--disable-e10s'], 14:09:13 INFO - 'tests': ['tp5o']}, 14:09:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'tests': ['tp5o']}, 14:09:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'talos_options': ['--disable-e10s', 14:09:13 INFO - '--xperf_path', 14:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:13 INFO - 'tests': ['tp5n']}, 14:09:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:09:13 INFO - 'talos_options': ['--xperf_path', 14:09:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:13 INFO - 'tests': ['tp5n']}}, 14:09:13 INFO - 'talos.zip': {'path': '', 14:09:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:13 INFO - Running post-action listener: _resource_record_post_action 14:09:13 INFO - ##### 14:09:13 INFO - ##### Finished populate-webroot step (success) 14:09:13 INFO - ##### 14:09:13 INFO - ##### 14:09:13 INFO - ##### Running create-virtualenv step. 14:09:13 INFO - ##### 14:09:13 INFO - Running pre-action listener: _resource_record_pre_action 14:09:13 INFO - Running main action method: create_virtualenv 14:09:13 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:13 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 14:09:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:13 INFO - Using real prefix '/usr' 14:09:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:13 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:15 INFO - Installing pip.................done. 14:09:15 INFO - Return code: 0 14:09:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09:15 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')]} 14:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:15 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')]} 14:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:15 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:15 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 14:09:15 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 14:09:15 INFO - Using env: {'DISPLAY': ':0', 14:09:15 INFO - 'HOME': '/home/cltbld', 14:09:15 INFO - 'LANG': 'en_US.UTF-8', 14:09:15 INFO - 'LANGUAGE': 'en_US:en', 14:09:15 INFO - 'LOGNAME': 'cltbld', 14:09:15 INFO - 'MAIL': '/var/mail/cltbld', 14:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:15 INFO - 'MOZ_NO_REMOTE': '1', 14:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:15 INFO - 'NO_EM_RESTART': '1', 14:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:15 INFO - 'PWD': '/builds/slave/test', 14:09:15 INFO - 'SHELL': '/bin/bash', 14:09:15 INFO - 'SHLVL': '1', 14:09:15 INFO - 'TERM': 'linux', 14:09:15 INFO - 'TMOUT': '86400', 14:09:15 INFO - 'USER': 'cltbld', 14:09:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:15 INFO - '_': '/tools/buildbot/bin/python'} 14:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:16 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 14:09:16 INFO - Cleaning up... 14:09:16 INFO - Return code: 0 14:09:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:16 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:16 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 14:09:16 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 14:09:16 INFO - Using env: {'DISPLAY': ':0', 14:09:16 INFO - 'HOME': '/home/cltbld', 14:09:16 INFO - 'LANG': 'en_US.UTF-8', 14:09:16 INFO - 'LANGUAGE': 'en_US:en', 14:09:16 INFO - 'LOGNAME': 'cltbld', 14:09:16 INFO - 'MAIL': '/var/mail/cltbld', 14:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:16 INFO - 'MOZ_NO_REMOTE': '1', 14:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:16 INFO - 'NO_EM_RESTART': '1', 14:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:16 INFO - 'PWD': '/builds/slave/test', 14:09:16 INFO - 'SHELL': '/bin/bash', 14:09:16 INFO - 'SHLVL': '1', 14:09:16 INFO - 'TERM': 'linux', 14:09:16 INFO - 'TMOUT': '86400', 14:09:16 INFO - 'USER': 'cltbld', 14:09:16 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:16 INFO - '_': '/tools/buildbot/bin/python'} 14:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:16 INFO - Downloading/unpacking psutil>=3.1.1 14:09:16 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 14:09:16 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 14:09:16 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 14:09:16 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 14:09:16 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 14:09:16 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 14:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:18 INFO - Installing collected packages: psutil 14:09:18 INFO - Running setup.py install for psutil 14:09:18 INFO - building 'psutil._psutil_linux' extension 14:09:18 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 14:09:18 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 14:09:18 INFO - building 'psutil._psutil_posix' extension 14:09:18 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 14:09:18 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 14:09:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:18 INFO - Successfully installed psutil 14:09:18 INFO - Cleaning up... 14:09:18 INFO - Return code: 0 14:09:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:18 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:18 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 14:09:18 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 14:09:18 INFO - Using env: {'DISPLAY': ':0', 14:09:18 INFO - 'HOME': '/home/cltbld', 14:09:18 INFO - 'LANG': 'en_US.UTF-8', 14:09:18 INFO - 'LANGUAGE': 'en_US:en', 14:09:18 INFO - 'LOGNAME': 'cltbld', 14:09:18 INFO - 'MAIL': '/var/mail/cltbld', 14:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:18 INFO - 'MOZ_NO_REMOTE': '1', 14:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:18 INFO - 'NO_EM_RESTART': '1', 14:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:18 INFO - 'PWD': '/builds/slave/test', 14:09:18 INFO - 'SHELL': '/bin/bash', 14:09:18 INFO - 'SHLVL': '1', 14:09:18 INFO - 'TERM': 'linux', 14:09:18 INFO - 'TMOUT': '86400', 14:09:18 INFO - 'USER': 'cltbld', 14:09:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:18 INFO - '_': '/tools/buildbot/bin/python'} 14:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09:19 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 14:09:19 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 14:09:19 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 14:09:19 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 14:09:19 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 14:09:19 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 14:09:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:21 INFO - Installing collected packages: mozsystemmonitor 14:09:21 INFO - Running setup.py install for mozsystemmonitor 14:09:21 INFO - Successfully installed mozsystemmonitor 14:09:21 INFO - Cleaning up... 14:09:21 INFO - Return code: 0 14:09:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09:21 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')]} 14:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:21 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')]} 14:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:21 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:21 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 14:09:21 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 14:09:21 INFO - Using env: {'DISPLAY': ':0', 14:09:21 INFO - 'HOME': '/home/cltbld', 14:09:21 INFO - 'LANG': 'en_US.UTF-8', 14:09:21 INFO - 'LANGUAGE': 'en_US:en', 14:09:21 INFO - 'LOGNAME': 'cltbld', 14:09:21 INFO - 'MAIL': '/var/mail/cltbld', 14:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:21 INFO - 'MOZ_NO_REMOTE': '1', 14:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:21 INFO - 'NO_EM_RESTART': '1', 14:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:21 INFO - 'PWD': '/builds/slave/test', 14:09:21 INFO - 'SHELL': '/bin/bash', 14:09:21 INFO - 'SHLVL': '1', 14:09:21 INFO - 'TERM': 'linux', 14:09:21 INFO - 'TMOUT': '86400', 14:09:21 INFO - 'USER': 'cltbld', 14:09:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:21 INFO - '_': '/tools/buildbot/bin/python'} 14:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:21 INFO - Downloading/unpacking jsonschema==2.5.1 14:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:23 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:23 INFO - warning: no files found matching '*.txt' 14:09:23 INFO - no previously-included directories found matching 'build' 14:09:23 INFO - no previously-included directories found matching 'dist' 14:09:23 INFO - no previously-included directories found matching '.git*' 14:09:23 INFO - Installing collected packages: jsonschema, functools32 14:09:23 INFO - Running setup.py install for functools32 14:09:23 INFO - warning: no files found matching '*.txt' 14:09:23 INFO - no previously-included directories found matching 'build' 14:09:23 INFO - no previously-included directories found matching 'dist' 14:09:23 INFO - no previously-included directories found matching '.git*' 14:09:23 INFO - Successfully installed jsonschema functools32 14:09:23 INFO - Cleaning up... 14:09:23 INFO - Return code: 0 14:09:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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', '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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:09: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 blobuploader==1.2.4 14:09:23 INFO - Using env: {'DISPLAY': ':0', 14:09:23 INFO - 'HOME': '/home/cltbld', 14:09:23 INFO - 'LANG': 'en_US.UTF-8', 14:09:23 INFO - 'LANGUAGE': 'en_US:en', 14:09:23 INFO - 'LOGNAME': 'cltbld', 14:09:23 INFO - 'MAIL': '/var/mail/cltbld', 14:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:23 INFO - 'MOZ_NO_REMOTE': '1', 14:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:23 INFO - 'NO_EM_RESTART': '1', 14:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:23 INFO - 'PWD': '/builds/slave/test', 14:09:23 INFO - 'SHELL': '/bin/bash', 14:09:23 INFO - 'SHLVL': '1', 14:09:23 INFO - 'TERM': 'linux', 14:09:23 INFO - 'TMOUT': '86400', 14:09:23 INFO - 'USER': 'cltbld', 14:09:23 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:23 INFO - '_': '/tools/buildbot/bin/python'} 14:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:23 INFO - Downloading/unpacking blobuploader==1.2.4 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:25 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:26 INFO - Downloading docopt-0.6.1.tar.gz 14:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:26 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:26 INFO - Running setup.py install for blobuploader 14:09:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:26 INFO - Running setup.py install for requests 14:09:27 INFO - Running setup.py install for docopt 14:09:27 INFO - Successfully installed blobuploader requests docopt 14:09:27 INFO - Cleaning up... 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:27 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:27 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 14:09:27 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 14:09:27 INFO - Using env: {'DISPLAY': ':0', 14:09:27 INFO - 'HOME': '/home/cltbld', 14:09:27 INFO - 'LANG': 'en_US.UTF-8', 14:09:27 INFO - 'LANGUAGE': 'en_US:en', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MAIL': '/var/mail/cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SHLVL': '1', 14:09:27 INFO - 'TERM': 'linux', 14:09:27 INFO - 'TMOUT': '86400', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - '_': '/tools/buildbot/bin/python'} 14:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:27 INFO - Running setup.py (path:/tmp/pip-xUWHgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:27 INFO - Running setup.py (path:/tmp/pip-qjefC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:27 INFO - Running setup.py (path:/tmp/pip-XPoM0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:27 INFO - Running setup.py (path:/tmp/pip-2I6N3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:27 INFO - Running setup.py (path:/tmp/pip-nbGInY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:27 INFO - Running setup.py (path:/tmp/pip-zFsv1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:27 INFO - Running setup.py (path:/tmp/pip-6SW1Ny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:27 INFO - Running setup.py (path:/tmp/pip-CKvHPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:28 INFO - Running setup.py (path:/tmp/pip-c0qZ6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:28 INFO - Running setup.py (path:/tmp/pip-i_DrI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:28 INFO - Running setup.py (path:/tmp/pip-yfeI_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:28 INFO - Running setup.py (path:/tmp/pip-ES6N4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:28 INFO - Running setup.py (path:/tmp/pip-fzl3GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:28 INFO - Running setup.py (path:/tmp/pip-fCSmy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:28 INFO - Running setup.py (path:/tmp/pip-O2Pp2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:28 INFO - Running setup.py (path:/tmp/pip-vRr8uQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:28 INFO - Running setup.py (path:/tmp/pip-CKlMsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:28 INFO - Running setup.py install for manifestparser 14:09:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:28 INFO - Running setup.py install for mozcrash 14:09:28 INFO - Running setup.py install for mozdebug 14:09:28 INFO - Running setup.py install for mozdevice 14:09:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozfile 14:09:29 INFO - Running setup.py install for mozhttpd 14:09:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozinfo 14:09:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozInstall 14:09:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozleak 14:09:29 INFO - Running setup.py install for mozlog 14:09:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for moznetwork 14:09:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Running setup.py install for mozprocess 14:09:29 INFO - Running setup.py install for mozprofile 14:09:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for mozrunner 14:09:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Running setup.py install for mozscreenshot 14:09:30 INFO - Running setup.py install for moztest 14:09:30 INFO - Running setup.py install for mozversion 14:09:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:30 INFO - Cleaning up... 14:09:30 INFO - Return code: 0 14:09:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:30 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:30 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 14:09:30 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 14:09:30 INFO - Using env: {'DISPLAY': ':0', 14:09:30 INFO - 'HOME': '/home/cltbld', 14:09:30 INFO - 'LANG': 'en_US.UTF-8', 14:09:30 INFO - 'LANGUAGE': 'en_US:en', 14:09:30 INFO - 'LOGNAME': 'cltbld', 14:09:30 INFO - 'MAIL': '/var/mail/cltbld', 14:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:30 INFO - 'MOZ_NO_REMOTE': '1', 14:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:30 INFO - 'NO_EM_RESTART': '1', 14:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:30 INFO - 'PWD': '/builds/slave/test', 14:09:30 INFO - 'SHELL': '/bin/bash', 14:09:30 INFO - 'SHLVL': '1', 14:09:30 INFO - 'TERM': 'linux', 14:09:30 INFO - 'TMOUT': '86400', 14:09:30 INFO - 'USER': 'cltbld', 14:09:30 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:30 INFO - '_': '/tools/buildbot/bin/python'} 14:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:30 INFO - Running setup.py (path:/tmp/pip-zWXJEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:30 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)) 14:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:30 INFO - Running setup.py (path:/tmp/pip-hc1COM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:30 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)) 14:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:30 INFO - Running setup.py (path:/tmp/pip-i8B4Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:30 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)) 14:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:30 INFO - Running setup.py (path:/tmp/pip-4yxpDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:30 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)) 14:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:30 INFO - Running setup.py (path:/tmp/pip-dTvDuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:31 INFO - Running setup.py (path:/tmp/pip-xMpuSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:31 INFO - Running setup.py (path:/tmp/pip-YlyDRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:31 INFO - Running setup.py (path:/tmp/pip-pN_tTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:31 INFO - Running setup.py (path:/tmp/pip-IyNhhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:31 INFO - Running setup.py (path:/tmp/pip-pFfLWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:31 INFO - Running setup.py (path:/tmp/pip-r_IsvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:31 INFO - Running setup.py (path:/tmp/pip-Iqn_H7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:31 INFO - Running setup.py (path:/tmp/pip-W_wg9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:31 INFO - Running setup.py (path:/tmp/pip-5R1Ux0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:31 INFO - Running setup.py (path:/tmp/pip-GY3Sph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:31 INFO - Running setup.py (path:/tmp/pip-i7szT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:31 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)) 14:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:31 INFO - Running setup.py (path:/tmp/pip-j_8gQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:31 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)) 14:09:31 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)) 14:09:31 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)) 14:09:31 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)) 14:09:31 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)) 14:09:31 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)) 14:09:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09: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 14:09:33 INFO - Downloading blessings-1.6.tar.gz 14:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:33 INFO - Installing collected packages: blessings 14:09:33 INFO - Running setup.py install for blessings 14:09:33 INFO - Successfully installed blessings 14:09:33 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:34 INFO - Reading from file tmpfile_stdout 14:09:34 INFO - Current package versions: 14:09:34 INFO - argparse == 1.2.1 14:09:34 INFO - blessings == 1.6 14:09:34 INFO - blobuploader == 1.2.4 14:09:34 INFO - docopt == 0.6.1 14:09:34 INFO - functools32 == 3.2.3-2 14:09:34 INFO - jsonschema == 2.5.1 14:09:34 INFO - manifestparser == 1.1 14:09:34 INFO - mozInstall == 1.12 14:09:34 INFO - mozcrash == 0.17 14:09:34 INFO - mozdebug == 0.1 14:09:34 INFO - mozdevice == 0.48 14:09:34 INFO - mozfile == 1.2 14:09:34 INFO - mozhttpd == 0.7 14:09:34 INFO - mozinfo == 0.9 14:09:34 INFO - mozleak == 0.1 14:09:34 INFO - mozlog == 3.2 14:09:34 INFO - moznetwork == 0.27 14:09:34 INFO - mozprocess == 0.22 14:09:34 INFO - mozprofile == 0.28 14:09:34 INFO - mozrunner == 6.11 14:09:34 INFO - mozscreenshot == 0.1 14:09:34 INFO - mozsystemmonitor == 0.3 14:09:34 INFO - moztest == 0.7 14:09:34 INFO - mozversion == 1.4 14:09:34 INFO - psutil == 3.1.1 14:09:34 INFO - requests == 1.2.3 14:09:34 INFO - wsgiref == 0.1.2 14:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'DISPLAY': ':0', 14:09:34 INFO - 'HOME': '/home/cltbld', 14:09:34 INFO - 'LANG': 'en_US.UTF-8', 14:09:34 INFO - 'LANGUAGE': 'en_US:en', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MAIL': '/var/mail/cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SHLVL': '1', 14:09:34 INFO - 'TERM': 'linux', 14:09:34 INFO - 'TMOUT': '86400', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - '_': '/tools/buildbot/bin/python'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 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)) 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'DISPLAY': ':0', 14:09:34 INFO - 'HOME': '/home/cltbld', 14:09:34 INFO - 'LANG': 'en_US.UTF-8', 14:09:34 INFO - 'LANGUAGE': 'en_US:en', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MAIL': '/var/mail/cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SHLVL': '1', 14:09:34 INFO - 'TERM': 'linux', 14:09:34 INFO - 'TMOUT': '86400', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - '_': '/tools/buildbot/bin/python'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09: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')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:09:34 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 0x7ffeeff98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x296c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a37350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, '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': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', '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 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'DISPLAY': ':0', 14:09:34 INFO - 'HOME': '/home/cltbld', 14:09:34 INFO - 'LANG': 'en_US.UTF-8', 14:09:34 INFO - 'LANGUAGE': 'en_US:en', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MAIL': '/var/mail/cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SHLVL': '1', 14:09:34 INFO - 'TERM': 'linux', 14:09:34 INFO - 'TMOUT': '86400', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - '_': '/tools/buildbot/bin/python'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:34 INFO - Downloading/unpacking flake8 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:34 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 14:09:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:09:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:09:36 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 14:09:36 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 14:09:36 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 14:09:36 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 14:09:36 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 14:09:36 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 14:09:37 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:09:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 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 14:09:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:37 INFO - no previously-included directories found matching 'docs/_build' 14:09:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:09:37 INFO - Running setup.py install for pep8 14:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:09:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:09:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:09:37 INFO - no previously-included directories found matching 'docs/_build' 14:09:37 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:09:37 INFO - Cleaning up... 14:09:37 INFO - Return code: 0 14:09:37 INFO - Running post-action listener: _resource_record_post_action 14:09:37 INFO - Running post-action listener: _start_resource_monitoring 14:09:37 INFO - Starting resource monitoring. 14:09:37 INFO - ##### 14:09:37 INFO - ##### Finished create-virtualenv step (success) 14:09:37 INFO - ##### 14:09:37 INFO - ##### 14:09:37 INFO - ##### Running install step. 14:09:37 INFO - ##### 14:09:37 INFO - Running pre-action listener: _resource_record_pre_action 14:09:37 INFO - Running main action method: install 14:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:38 INFO - Reading from file tmpfile_stdout 14:09:38 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:38 INFO - Reading from file tmpfile_stdout 14:09:38 INFO - Output received: 14:09:38 INFO - Usage: mozinstall [options] installer 14:09:38 INFO - Options: 14:09:38 INFO - -h, --help show this help message and exit 14:09:38 INFO - -d DEST, --destination=DEST 14:09:38 INFO - Directory to install application into. [default: 14:09:38 INFO - "/builds/slave/test"] 14:09:38 INFO - --app=APP Application being installed. [default: firefox] 14:09:38 INFO - mkdir: /builds/slave/test/build/application 14:09:38 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'] 14:09:38 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 14:09:54 INFO - Reading from file tmpfile_stdout 14:09:54 INFO - Output received: 14:09:54 INFO - /builds/slave/test/build/application/firefox/firefox 14:09:54 INFO - Running post-action listener: _resource_record_post_action 14:09:54 INFO - ##### 14:09:54 INFO - ##### Finished install step (success) 14:09:54 INFO - ##### 14:09:54 INFO - ##### 14:09:54 INFO - ##### Running run-tests step. 14:09:54 INFO - ##### 14:09:54 INFO - Running pre-action listener: _resource_record_pre_action 14:09:54 INFO - Running main action method: run_tests 14:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:54 INFO - Python 2.7.3 14:09:54 INFO - Return code: 0 14:09:54 INFO - grabbing minidump binary from tooltool 14:09:54 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')]} 14:09:54 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 0x2ac61c0>, '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 0x2ac70c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ac7550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:54 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 14:09:54 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 14:09:54 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 14:09:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:55 INFO - Return code: 0 14:09:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:09:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:09:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:09:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:09:55 INFO - Return code: 0 14:09:55 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:09:55 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:09:55 INFO - Using env: {'DISPLAY': ':0', 14:09:55 INFO - 'HOME': '/home/cltbld', 14:09:55 INFO - 'LANG': 'en_US.UTF-8', 14:09:55 INFO - 'LANGUAGE': 'en_US:en', 14:09:55 INFO - 'LOGNAME': 'cltbld', 14:09:55 INFO - 'MAIL': '/var/mail/cltbld', 14:09:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:09:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:55 INFO - 'MOZ_NO_REMOTE': '1', 14:09:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:55 INFO - 'NO_EM_RESTART': '1', 14:09:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:55 INFO - 'PWD': '/builds/slave/test', 14:09:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:55 INFO - 'SHELL': '/bin/bash', 14:09:55 INFO - 'SHLVL': '1', 14:09:55 INFO - 'TERM': 'linux', 14:09:55 INFO - 'TMOUT': '86400', 14:09:55 INFO - 'USER': 'cltbld', 14:09:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1465420072.647511-1494502784', 14:09:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:55 INFO - '_': '/tools/buildbot/bin/python'} 14:09:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:09:56 INFO - mozversion application_buildid: 20160608113003 14:09:56 INFO - mozversion application_changeset: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 14:09:56 INFO - mozversion application_display_name: Nightly 14:09:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:56 INFO - mozversion application_name: Firefox 14:09:56 INFO - mozversion application_remotingname: firefox 14:09:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:09:56 INFO - mozversion application_vendor: Mozilla 14:09:56 INFO - mozversion application_version: 50.0a1 14:09:56 INFO - mozversion platform_buildid: 20160608113003 14:09:56 INFO - mozversion platform_changeset: 62ad4f6b5c3428e4b33e1e4ba75288c94c45ec92 14:09:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:09:56 INFO - mozversion platform_version: 50.0a1 14:09:56 INFO - using testdate: 1465420196 14:09:56 INFO - actual date: 1465420196 14:09:56 INFO - starting webserver on 'localhost:43353' 14:09:56 INFO - SUITE-START | Running 2 tests 14:09:56 INFO - TEST-START | dromaeo_css 14:09:56 INFO - operating with platform_type : linux_ 14:09:56 INFO - Initialising browser for dromaeo_css test... 14:09:56 INFO - TEST-INFO | started process 4016 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphztQSC/profile http://localhost:43353/getInfo.html) 14:10:00 INFO - PROCESS | 4016 | __metrics Screen width/height:1600/1200 14:10:00 INFO - PROCESS | 4016 | colorDepth:24 14:10:00 INFO - PROCESS | 4016 | Browser inner width/height: 1024/697 14:10:00 INFO - PROCESS | 4016 | __metrics 14:10:01 ERROR - PROCESS | 4016 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:10:02 INFO - TEST-INFO | 4016: exit 0 14:10:02 INFO - Browser initialized. 14:10:02 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:02 INFO - TEST-INFO | started process 4134 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphztQSC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:14 INFO - PROCESS | 4134 | RSS: Main: 167395328 14:10:14 INFO - PROCESS | 4134 | 14:11:03 INFO - PROCESS | 4134 | 1465420263842 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] 14:13:11 INFO - PROCESS | 4134 | Cycle 1(1): loaded http://localhost:43353/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43353/tests/dromaeo/cssquery-ext.html) 14:13:12 INFO - PROCESS | 4134 | RSS: Main: 171765760 14:13:12 INFO - PROCESS | 4134 | 14:16:14 INFO - PROCESS | 4134 | Cycle 1(1): loaded http://localhost:43353/tests/dromaeo/cssquery-ext.html (next: http://localhost:43353/tests/dromaeo/cssquery-jquery.html) 14:16:14 INFO - PROCESS | 4134 | RSS: Main: 170143744 14:16:14 INFO - PROCESS | 4134 | 14:19:16 INFO - PROCESS | 4134 | Cycle 1(1): loaded http://localhost:43353/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43353/tests/dromaeo/cssquery-mootools.html) 14:19:17 INFO - PROCESS | 4134 | RSS: Main: 171778048 14:19:17 INFO - PROCESS | 4134 | 14:22:19 INFO - PROCESS | 4134 | Cycle 1(1): loaded http://localhost:43353/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43353/tests/dromaeo/cssquery-prototype.html) 14:22:19 INFO - PROCESS | 4134 | RSS: Main: 169275392 14:22:19 INFO - PROCESS | 4134 | 14:25:22 INFO - PROCESS | 4134 | Cycle 1(1): loaded http://localhost:43353/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43353/tests/dromaeo/cssquery-yui.html) 14:25:22 INFO - PROCESS | 4134 | RSS: Main: 171253760 14:25:22 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | Cycle 1(1): loaded http://localhost:43353/tests/dromaeo/cssquery-yui.html (next: http://localhost:43353/tests/dromaeo/cssquery-dojo.html) 14:28:25 INFO - PROCESS | 4134 | RSS: Main: 172158976 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | __start_tp_report 14:28:25 INFO - PROCESS | 4134 | _x_x_mozilla_page_load 14:28:25 INFO - PROCESS | 4134 | _x_x_mozilla_page_load_details 14:28:25 INFO - PROCESS | 4134 | |i|pagename|runs| 14:28:25 INFO - PROCESS | 4134 | |0;dojo.html;3177.158053115924;3179.761517886158;3183.5065564837428;3219.597550306212;3223.854926528306;5336.573074154068;5441.347038355398;5457.590680698949;5525.585581081415;5525.613207075507;5406.08096623574;5515.034868897937;5517.200005999128;5536.446355364462;5593.356763972144;5028.8239911603105;5073.3404657394485;5116.488351164872;5148.279240906276;5189.896202075956;743.5089328402628;4926.211806111023;4936.629752768539;5094.235864620318;5099.235114732801;4988.152014157566;4996.350474438336;5044.646874718789;5053;5096.541311281984;4988.201887697951;4989.126902792033;5011.799528018875;5055.064813009605;5059.74701264939;4924.729139897304;4928.334674818925;4931.7780699868235;4965.23038928963;4996.2755400467095;5378.569714422837;5380.112281473552;5388.865278368033;5401.378841433207;5409.134538473825;5775.5957083004205;5848.7075646217945;5862.163714935153;5872.5889187756875;5907.763689452417;5788.04497257952;5855.912161317584;5891.617044892068;5899.5280377570125;5963.314218864799;5542.501174894279;5547.750351234205;5553.7778488860395;5556.805511807108;5560.582956278296;5908.231929849092;6024.3975602439405;6033.064874944391;6037.818865434044;6048.0625503047095;5744.569157313218;5827.125931110368;5876.265466816648;5900.055991041413;5915.585908986416;5982.282126144891;6020.638761674313;6029.909551356734;6032.788852390146;6034.607750496204;5781.277340332458;5929.644221346733;5994.460498555064;6011.549133814981;6020.127081573148;5783.277090363705;5818.592698511148;5839.941600583939;5869.765209391662;5874.236349274653;4415.2935530315;4419.624331931757;4435.578620031092;4457.799399027052;4479.148961697267;3919.392494163409;3922.5489068756888;3925.8822235332987;3970.622790834866;3981.8606348778235;5462.180672899018;5540.63985840919;5553.222548843165;5561.416051314553;5616.269884914935;5802.361740208574;5890.028145356054;5914.408559144051;5922.082077278029;5932.110183472513;5580.91628625571;5599.300087489064;5630.971845140748;5642.492175704207;5643.435656434323;5024.673396229234;5061.291419201241;5063.367079115111;5129.12804823181;5134.306868572769;5977.850553736192;6025.487833534111;6029.186059881859;6072.180255665517;6081.391860813883;5778.56660750437;5825.825225243249;5897.970510147507;5945.791897283574;5967.701614919323;5919.348871624204;5933.258342707161;5967.134765458897;6078.118672792509;6120.296165940974;5802.245708057925;5853.239078919713;5858.326292476419;5869.266341707286;5883.352831188651;5871.6770577618645;5990.7304171311525;5996.070609055603;5998.610090344114;6001.879962400815;5778.595498315078;5813.970930145322;5838.12428135783;5842.766289348378;5880.970595146997;5816.563757718272;5833.708314584339;5834.15404766315;5842.941570584239;5843.912341314799;5441.700706461183;5479.205515200353;5663.830085097454;5687.715614219355;5701.486866182064;5685.488306052475;5702.7718891243885;5756.625819321731;5756.971215143897;5770.6249093808765;5576.7211639417055;5578;5579.637323573955;5585;5585.497305242385 14:28:25 INFO - PROCESS | 4134 | |1;ext.html;563.3296377311;599.0385431382631;618.6350053468458;619.2383368456799;629.3611983836407;41609.58390416095;42875.14249715012;43020.78489607555;43122.35316470255;46148.769256153675;44507.33239001418;44805.55194448055;45231.77384113083;45272.54727452724;45344.3198352025;8666.91333086669;8825.161609647073;8831.95584022079;8840.425372350808;8860.379773415863;8570.142985701443;8705.434146780439;8746.125387461267;8765.868511972325;8789.64841406343;8720;8790.252828509585;8799.032106468283;8839.867401988975;8845;8607.268382187522;8696.956515217384;8698;8710.346723995663;8798.47209167452;8714.041455439896;8720.171583699603;8800.515971621558;8805.559722013873;8814.382993190478;41038.794806026075;41238.587614123775;41495.37756933648;41607.37588936168;41706;3631.6186800385844;3680.4479328100733;3736.8878933631763;4022.4368588397647;4057.3508238681966;31709;31736.36527269465;31952;32208.194795130075;32423.675763242303;4150.481189851269;4179.832806687759;4242.406063151161;4253.447051883235;4350.260455722503;331332;331350;331906;335279.32360338286;335493;33392.83303583515;56605.716971415706;56793.43206567964;56878.14682779762;56893;34039.489407658904;35823.64176358203;35913.64086359103;36106.27787444289;36207.63792362042;15171.620709482351;15254.771178432333;15350.07899526032;15359.462418815288;15397.538073857802;12840.807387889188;12934;13013.154144980546;13027.283499407624;13043.217406955613;8310.958445207736;8321.126281740451;8331.37514686401;8375.288100511403;8400.453970491899;3201.743860491155;3203;3205.3909757146066;3270.084376374619;3319.286353434023;1008.4856723071287;1046.3355769086684;1084.6203828660064;1088.874779400379;1118.3513562133942;31370.52944205839;32130;32186.517202241987;32464;32498.35003299921;1107.1087774341572;1111.2054880760295;1157.4155051698838;1179.870214276429;1212.6422705301957;16207;16635.50093497197;16707.164641768108;16726.581835453966;17006.829931700773;538686;546798;547869;549270;554331;55726.16410753842;57332;57393.71303143458;57512.712436438385;57607.42392576021;1347.3061373392711;1364.6520137364907;1381.5717127690448;1394.4073768648284;1398.5105213175307;29297.70702293035;30494.237644059074;30558.236044099074;30699;30803.84598076995;48505.5149448501;48929.2660610084;49115.75442122766;49202;49352.50647493479;435374;446486;446954;447111;447898;27424;27507;27547.31131721723;27593.310167245978;27643;45897.54102458933;46285;47303.925244858976;47645.76177119092;48006.279905800744;39803.60196397999;40054.39918401168;40520.71289023601;41162.79418602888;41571;39051.80474097611;39335.40996885106;39787.60212397839;39863;40040.799796000836;39426.80286598549;39628.40557391699;39923.60076399199;40373.798131009156;40695;34131.48802767911;36801.26397472089;37164.25671486609;37295.44056839095;37899.24201515899;27789.58315625227;28111.71888281091;28153;28288.71711282861;28619.855205791537 14:28:25 INFO - PROCESS | 4134 | |2;jquery.html;384.5539174557514;384.8691444908731;388.10721584656494;391.63773509503704;410.2758631016257;17457.563560910967;18809.529761755963;19010.904945475253;19220.519487012833;19839.801601983974;18685.626287474242;18922.90538547309;19276.421707348767;19430.611387772235;19491.317803876867;5455.427180146087;5482.780688772445;5606.187102870082;5612.709076912312;5662.094064949609;5522.779088836442;5548.58385621078;5559.805406810762;5577.8047768328115;5594.049011668027;5284.894302113956;5525.778968841241;5548.55611551075;5552.3892371839065;5557.805476808313;5429.619926605139;5562.99999999998;5581.5255703265475;5628.746706398201;5760.855978600569;5598.748056337434;5600.52395546379;5627.746751396197;5638.492535671769;5662.235598194232;13396.93301533486;16120.838791612052;20934.325253979645;22243.888780556157;22266.777332226633;2182.8430931606117;2207.635740102897;2217.434554188688;2236.9888150559304;2275.328778010491;9961.153301969342;10163.441010744406;10263.538140783608;10487.161027117812;10500;1937.4962509747427;1964.2044971786306;1978.3570339639675;1986.255154317131;2027.2701827342146;74641;75554.24445755527;76241.61879190624;76885.61557192178;77420.22579774186;10617.893821061845;10808.94595527033;11451.312921224753;11632.592859250055;11839.88160118405;15010.849891501164;15061.698766024618;15173.393064277527;15249.695006099815;15272.618184545254;8028.237317454949;8243.793905152299;8289.41974061822;8314.376421768391;8409.621567029377;7186.892196617055;7246.492745507764;7344.706211751577;7346.265373462611;7776.766696999099;4581.885452863705;4608;4615.538446155425;4629.768511574408;4691.601213896789;1902.4482899958857;1937.5349916020054;1937.6705959986837;1938.457231975021;1971.5662554238045;903.2773780975193;981.6858605246252;982.5676702250987;1006.5571148694551;1043.0508237503834;17983.73024404635;18280.360187393377;18553.165107570192;18878.52803679919;19002.144903479377;1004.1163775877327;1018.6943916824923;1038.4496217004998;1046.9005444482762;1096.4188979840696;9387.009324448998;10459.320144190755;10493.317934334396;10618.946905265579;10628.415437150876;460965;469777;481308;482146;482837;95252.52373738226;96907.51546242223;97081.514592428;97170;97234.51382743183;1001.6494227020485;1023.3808545829665;1043.660810236676;1045.487711021594;1049.7218237167158;16248.837511624732;16744.41394551185;16835.66328673395;17014.14929253557;17095.48713538596;28648;37166.62833371632;43254.78372608242;43394;45088.774556127006;58053.709731451076;58872.705636471546;59458;59822.102668459134;60359;7309.378702810108;7603.885941710768;8117.675292988214;8432.156784321518;8694.739157825023;12434.129610927148;12760.234385936874;12894.29081400532;13238.867611324149;13263.137896036727;11013.889861101286;11337.943310283395;11397.202195846543;11544.076473882238;11593.768124637292;11387.43062846871;11440.542378304775;11453.713657158305;11522.76954460923;11647.708807279885;11018.44907754593;11344.20590558653;11486.82769758471;11664.533418663159;11941.223820451643;7752.728654497066;7867.252611001945;7931.881021784793;7957.1644977276555;7989.920100798918;9801.607935682492;11354.659360219206;11369.602063927723;11525.308481491138;11600.825987610362 14:28:25 INFO - PROCESS | 4134 | |3;mootools.html;1462.064278861529;1501.294391635931;1596.146061856906;1728.6888360095177;1756.279925230654;7881.92118078819;8555;8588.227059564639;9096.272298216143;9098.772530686729;8655;8914.86627700585;8964.058773828752;8994.595243214055;9005.819883602324;2331.0675729708123;2339.7426283108844;2350.3066595354326;2361.244401791427;2364.6689463475127;2309.595820731374;2332.0904847109555;2371.4782747795457;2377.2749311459997;2382.809375249976;2303.6314189729646;2316.363000174957;2323.825713071518;2370.739218685952;2376.5484557934024;2262.592733308004;2266.7166604174477;2276.8747718875456;2291.163725240284;2297.574948634508;2357.6934998450265;2357.7642235776457;2362.9409264768346;2381.047580967627;2386.069432921162;8826.86759698605;8880.1563851434;8913.242374398184;8961.014288428267;8970.50662213578;5087.949120508822;5142.30578871855;5212.4266330703595;5290.973545132289;5337.06601344767;3210.7752457327997;3363.1087761743156;3394.541736865516;3412.5563676721868;3423.6747508986605;1100.2023532938636;1164.2723297938787;1170.5142365918134;1195.8206269059624;1207.6135636596293;12352.814707779391;12377.071719621064;12413.627591172279;12417.93791031048;12425.689357766038;4507.143642707875;4593.632509399307;4634.304854271886;4668.50980647034;4712.69367491112;10345.431001295;10389.84415233757;10453.163746900229;10460.68617941463;10471.214658900613;5283.735813209324;5285.493634314202;5295.4439783822145;5310.176922577007;5322.654027488201;4244.427002354704;4685.461171965199;4788.233882578771;4797.64017698674;4862.975685121552;4092.0792821615496;4112.3420252759415;4120.157175998373;4131.5248746393945;4134.297169481196;1298.8506321773118;1300.408314217048;1321.378951892609;1336.9933150334186;1358.585631382438;789.2344425906975;928.9038934057742;953.8950715421298;996.6611352140162;1004.7036124343336;5768.711564421762;5858.945389829872;5921.2302400688495;6149.723262453201;6239.188905442264;1045.5869931377215;1051.5163025008583;1088.2327958789035;1099.7360633447915;1102.895224953628;4038.8788336349958;4098.446709694213;4106.835726570904;4266.146770645883;4269.978650106729;10775.191860610486;11110;11161.386123763108;11173.497192626352;11197;10086.546105425274;10909.563617455371;11007.284526505911;11012.339259644446;11031.944840275748;8082.353411727047;8399.538025408661;8422.663093476192;8426.578671066545;8505.23452889243;5938.376470470538;5998.1002849572915;6060.787872424444;6127.080937859357;6233.2208473940755;9887.85168222463;10155.593776248867;10165.898341016495;10208.438535880598;10214.897851021691;10316.535755891153;10366.170706343626;10591.4704264788;10603.204759642904;10637.468126593794;8236.50580965144;8422.199891010345;8457.40798144124;8576.228139467477;8607.139286071342;8431.957840211006;8489.405741598275;8498.02272738643;8513.063563008189;8527.701530446404;7571;7683.039620047494;7811.921880781119;7905.762827115196;7941.6029198541;7672.0409948756405;7673.693052278069;7693.615319234128;7699.576523291273;7933.206679332251;7026.929730702627;7089.184743754328;7092.184398793998;7125.394341480825;7177.672130655846;4854.5873600744335;5069.543741063322;5166.974165129301;5170.482951704799;5323.148296272578;5168.095583272988;5203.765830537559;5205.245239440335;5211.426743058337;5253.50091741284 14:28:25 INFO - PROCESS | 4134 | |4;prototype.html;321.2178345728151;329.1901921273667;331.14729571353763;333.57968959111525;334.9464085746281;5478.424765399631;5538.695371754552;5565.554755619551;5583.637063590863;5588.552915766739;5543.835794483153;5545.889082218353;5560.193771903072;5568.605499635155;5575.609707320489;4316.870493885189;4317.913641727164;4326.43756311679;4331.45856767904;4346.109047645241;4233.915321693565;4259.190753756776;4343.565643435647;4350.36919646651;4360.127974405116;4265.893352666177;4266.146770645883;4268.167707297078;4295.72077814941;4303.203907277164;4283.3146696528565;4295.72077814941;4308.418363520932;4325.15659446405;4336.349547567858;3767.2465506898457;3824.158685089276;3861.613838616144;3866.5360156781367;3872.4191371294532;5353.357597088374;5375.22059301403;5381.300430943952;5399.865003374908;5402.567794576464;4895.143349913787;4897.461279259279;4910.895048614069;4913.852584422437;4916.139675556799;5704.401037891044;5776.797812076599;5785.247917770705;5812.534997200214;5858.648481091105;4173.812178451977;4174.958250417518;4178.247915375231;4186.28833098371;4202.747835129902;5798.449147330997;6093.96953015241;6105.32841387447;6109.541784366191;6121.938780612226;4163;4173.353130264753;4174.624283814472;4176.248275310412;4194.601512856274;4243.342281946303;4245.150969806051;4267.615914567642;4272.316429371285;4279.229738647011;4814.301926220748;4845.491223421561;4891.6575839691595;4905.141600219948;4923.827666031743;5823.825285241365;5831.358550559435;5834.5624078194305;5852.795152169739;5856.355800861902;1442.4590778458078;1467.955961321162;1476.6308422894276;1480.8000919875894;1483.7700156475764;887.3522328700085;944.6127087894068;945.2013048973606;947.928905332089;956.8086382723483;5032.396112466454;5048.974755126201;5076.035553244872;5113.51421614946;5168;5288.603354748409;5360.989628889167;5398.91901621476;5419.187121931663;5478.260869565217;4697.6711630185555;4993.350864387679;5048.570871475892;5058;5133.383993920679;2879.467298549775;2891.956620650692;2900.9258380258216;2902.8258304501796;2908.7672986161056;5451.454854514596;5460.754266058037;5485.780568777204;5525.76206636313;5532.7786888524815;5459.143891077053;5659.717014149276;6191.690415479208;6196.969015154896;6221.875562488724;6203.503719702413;6231.657258850807;6258.436740693269;6265.248170219512;6274.027525733519;5964.300174450261;5997.860406522746;6076.900780601836;6148.538859585459;6160.33670908861;5961.433663801932;6053.668192997534;6082.878342433038;6095.695215239131;6122.938770612237;5921.822345329475;6041.365656605993;6154.415330543591;6192.876142477216;6220.413794482559;4177.540470548298;4197.685173611931;4202.663786897102;4208.579142085767;4218.81015354316;5836.970815145897;6046.486048685911;6060.939390606038;6085.269767627913;6130.325664177026;5818.301803783573;5898.262717160355;5917.408259174048;5940.227770389822;5941.287045554561;5806.187133801355;5813.680247586423;5900.409959004237;5921;5938.524918006463;5556.888862222814;5651.378348381592;5763.682997435014;5777.768889244383;5782.190493330853;5926.4666180044005;5957.523398128226;5968.060380376482;5969.910451343147;5990.1913241713555;5646.322441307069;5760.740766665426;5843.094320380348;5843.649381037151;5860.38465961068 14:28:25 INFO - PROCESS | 4134 | |5;yui.html;697.4315932515;715.3633266392908;720.8378114924141;758.4652819762068;826.6280173921734;14114.505992290271;14916.254187290619;15002.174880381575;15033.022853514527;15072.6985460291;14723.411063557473;14827.406903723864;14956;14972.17653029083;14973.700525989474;781.0705260739716;790.5849429049738;804.6660635836121;808.5512540539997;809.4697972827807;805.8630032894422;807.410590269101;815.2377527012233;815.4088285992667;815.9184081591823;845.8350621628784;856.6787454704486;856.7001549457672;856.7686724584389;857.1856736100698;848.4273115646976;850.5789634131145;850.6639877248483;851.2551517422255;852.1521086518923;617.077469183569;618.3167599802199;622.1631905087695;622.4335854372499;622.6357580815229;15782.368705251776;15907.443239486678;15909.52271431859;15913.363465461367;15923.52229433119;14967.550973470814;15105.924470377578;15135.091894486366;15151.696966060617;15204.391824327015;12511.249325040526;12594.307313097775;12607.306598137098;12764.936175319064;13376.933115334361;3795.2409518096492;3827.598897874323;3845.4231865220163;3884.7280690351686;3952.051507638146;79261.60369198174;79416.60291698562;81879;82475;83054.58472707658;11716;11721.706957326134;11723.120765942589;11835.349055802013;12236.632901012983;21515.462113447287;21520.677189842165;21552;21566.353009409744;21590.352289431343;8526.360522960678;8917.28661707075;8966.148215919608;9115.134062264075;9171.082891710908;4823.95176048235;4842.394700662418;4981.676191047571;5010.023045506165;5087.033463641897;3490.47642853574;3614;3615.439606860941;3631.455281707712;3644.0889777555612;506.17493485618206;609.0985341694317;614.0574218574467;618.730852079347;618.8267285160163;593.6289818863211;595.0627761276007;653.5491209514869;656.3567703650449;691.2223748283182;9052.8642070369;9187.540622968825;9235.492047937294;9275.58259878307;9482.525873706425;608.2913405882186;674.2650510942998;696.3663066609361;712.2272334517004;713.9000539924415;4359.912801744011;4379.1460665170625;4425.889352766207;4494.685372023992;4560.703554268962;78919.60540197263;104793;113091;121076.39461802634;121169.39415303043;64582.354176458575;85701.57149214338;93809;97751.51124244333;97901.5104924485;83851.74222386669;83941.58029209815;84087.15912840793;85602;87511;8244.876326854983;8256.752297431087;8429.008135262517;8469.280111190617;8502.617382217692;51219.2317115251;51621.48378516167;52055.219171711695;52486.47513524816;53884;71481.6425917867;72694;73635;73672;74090.62954685408;10430.68707938763;10769.353838769699;10837.945810270898;10904.127669786556;11182.776344472903;12541.372931353213;12826.166299190523;12857.807132893202;12935.353232338533;13003.544875929298;11324.94337528307;11668.533258669559;11712.180147389601;11811.704707382385;12306.569270075863;12465.127441079037;13460.798088028883;13519.729605408034;14088.577342679737;14179.361928713026;13949.16305021702;13997.160170389809;14004.229767362893;14190.361433735301;14590.124592524482;10969;11398.08815294758;11490.655280341603;11936;12082.33547154915;11383.260088094248;11535.36555489456;11910.707076748296;11935.462904169159;11976.880231197576 14:28:25 INFO - PROCESS | 4134 | __end_tp_report 14:28:25 INFO - PROCESS | 4134 | __start_cc_report 14:28:25 INFO - PROCESS | 4134 | _x_x_mozilla_cycle_collect,342 14:28:25 INFO - PROCESS | 4134 | __end_cc_report 14:28:25 INFO - PROCESS | 4134 | __startTimestamp1465421305518__endTimestamp 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | ------- Summary: start ------- 14:28:25 INFO - PROCESS | 4134 | Number of tests: 6 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | [#0] dojo.html Cycles:165 Average:5443.65 Median:5685.49 stddev:727.58 (12.8%) stddev-sans-first:707.76 14:28:25 INFO - PROCESS | 4134 | Values: 3177.2 3179.8 3183.5 3219.6 3223.9 5336.6 5441.3 5457.6 5525.6 5525.6 5406.1 5515.0 5517.2 5536.4 5593.4 5028.8 5073.3 5116.5 5148.3 5189.9 743.5 4926.2 4936.6 5094.2 5099.2 4988.2 4996.4 5044.6 5053.0 5096.5 4988.2 4989.1 5011.8 5055.1 5059.7 4924.7 4928.3 4931.8 4965.2 4996.3 5378.6 5380.1 5388.9 5401.4 5409.1 5775.6 5848.7 5862.2 5872.6 5907.8 5788.0 5855.9 5891.6 5899.5 5963.3 5542.5 5547.8 5553.8 5556.8 5560.6 5908.2 6024.4 6033.1 6037.8 6048.1 5744.6 5827.1 5876.3 5900.1 5915.6 5982.3 6020.6 6029.9 6032.8 6034.6 5781.3 5929.6 5994.5 6011.5 6020.1 5783.3 5818.6 5839.9 5869.8 5874.2 4415.3 4419.6 4435.6 4457.8 4479.1 3919.4 3922.5 3925.9 3970.6 3981.9 5462.2 5540.6 5553.2 5561.4 5616.3 5802.4 5890.0 5914.4 5922.1 5932.1 5580.9 5599.3 5631.0 5642.5 5643.4 5024.7 5061.3 5063.4 5129.1 5134.3 5977.9 6025.5 6029.2 6072.2 6081.4 5778.6 5825.8 5898.0 5945.8 5967.7 5919.3 5933.3 5967.1 6078.1 6120.3 5802.2 5853.2 5858.3 5869.3 5883.4 5871.7 5990.7 5996.1 5998.6 6001.9 5778.6 5814.0 5838.1 5842.8 5881.0 5816.6 5833.7 5834.2 5842.9 5843.9 5441.7 5479.2 5663.8 5687.7 5701.5 5685.5 5702.8 5756.6 5757.0 5770.6 5576.7 5578.0 5579.6 5585.0 5585.5 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | [#1] ext.html Cycles:180 Average:58768.24 Median:40447.26 stddev:119772.17 (296.1%) stddev-sans-first:120028.44 14:28:25 INFO - PROCESS | 4134 | Values: 563.3 599.0 618.6 619.2 629.4 41609.6 42875.1 43020.8 43122.4 46148.8 44507.3 44805.6 45231.8 45272.5 45344.3 8666.9 8825.2 8832.0 8840.4 8860.4 8570.1 8705.4 8746.1 8765.9 8789.6 8720.0 8790.3 8799.0 8839.9 8845.0 8607.3 8697.0 8698.0 8710.3 8798.5 8714.0 8720.2 8800.5 8805.6 8814.4 41038.8 41238.6 41495.4 41607.4 41706.0 3631.6 3680.4 3736.9 4022.4 4057.4 31709.0 31736.4 31952.0 32208.2 32423.7 4150.5 4179.8 4242.4 4253.4 4350.3 331332.0 331350.0 331906.0 335279.3 335493.0 33392.8 56605.7 56793.4 56878.1 56893.0 34039.5 35823.6 35913.6 36106.3 36207.6 15171.6 15254.8 15350.1 15359.5 15397.5 12840.8 12934.0 13013.2 13027.3 13043.2 8311.0 8321.1 8331.4 8375.3 8400.5 3201.7 3203.0 3205.4 3270.1 3319.3 1008.5 1046.3 1084.6 1088.9 1118.4 31370.5 32130.0 32186.5 32464.0 32498.4 1107.1 1111.2 1157.4 1179.9 1212.6 16207.0 16635.5 16707.2 16726.6 17006.8 538686.0 546798.0 547869.0 549270.0 554331.0 55726.2 57332.0 57393.7 57512.7 57607.4 1347.3 1364.7 1381.6 1394.4 1398.5 29297.7 30494.2 30558.2 30699.0 30803.8 48505.5 48929.3 49115.8 49202.0 49352.5 435374.0 446486.0 446954.0 447111.0 447898.0 27424.0 27507.0 27547.3 27593.3 27643.0 45897.5 46285.0 47303.9 47645.8 48006.3 39803.6 40054.4 40520.7 41162.8 41571.0 39051.8 39335.4 39787.6 39863.0 40040.8 39426.8 39628.4 39923.6 40373.8 40695.0 34131.5 36801.3 37164.3 37295.4 37899.2 27789.6 28111.7 28153.0 28288.7 28619.9 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | [#2] jquery.html Cycles:180 Average:28291.68 Median:22255.33 stddev:78563.26 (353.0%) stddev-sans-first:78755.71 14:28:25 INFO - PROCESS | 4134 | Values: 384.6 384.9 388.1 391.6 410.3 17457.6 18809.5 19010.9 19220.5 19839.8 18685.6 18922.9 19276.4 19430.6 19491.3 5455.4 5482.8 5606.2 5612.7 5662.1 5522.8 5548.6 5559.8 5577.8 5594.0 5284.9 5525.8 5548.6 5552.4 5557.8 5429.6 5563.0 5581.5 5628.7 5760.9 5598.7 5600.5 5627.7 5638.5 5662.2 13396.9 16120.8 20934.3 22243.9 22266.8 2182.8 2207.6 2217.4 2237.0 2275.3 9961.2 10163.4 10263.5 10487.2 10500.0 1937.5 1964.2 1978.4 1986.3 2027.3 74641.0 75554.2 76241.6 76885.6 77420.2 10617.9 10808.9 11451.3 11632.6 11839.9 15010.8 15061.7 15173.4 15249.7 15272.6 8028.2 8243.8 8289.4 8314.4 8409.6 7186.9 7246.5 7344.7 7346.3 7776.8 4581.9 4608.0 4615.5 4629.8 4691.6 1902.4 1937.5 1937.7 1938.5 1971.6 903.3 981.7 982.6 1006.6 1043.1 17983.7 18280.4 18553.2 18878.5 19002.1 1004.1 1018.7 1038.4 1046.9 1096.4 9387.0 10459.3 10493.3 10618.9 10628.4 460965.0 469777.0 481308.0 482146.0 482837.0 95252.5 96907.5 97081.5 97170.0 97234.5 1001.6 1023.4 1043.7 1045.5 1049.7 16248.8 16744.4 16835.7 17014.1 17095.5 28648.0 37166.6 43254.8 43394.0 45088.8 58053.7 58872.7 59458.0 59822.1 60359.0 7309.4 7603.9 8117.7 8432.2 8694.7 12434.1 12760.2 12894.3 13238.9 13263.1 11013.9 11337.9 11397.2 11544.1 11593.8 11387.4 11440.5 11453.7 11522.8 11647.7 11018.4 11344.2 11486.8 11664.5 11941.2 7752.7 7867.3 7931.9 7957.2 7989.9 9801.6 11354.7 11369.6 11525.3 11600.8 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | [#3] mootools.html Cycles:180 Average:5871.62 Median:4388.56 stddev:3332.33 (75.9%) stddev-sans-first:3325.20 14:28:25 INFO - PROCESS | 4134 | Values: 1462.1 1501.3 1596.1 1728.7 1756.3 7881.9 8555.0 8588.2 9096.3 9098.8 8655.0 8914.9 8964.1 8994.6 9005.8 2331.1 2339.7 2350.3 2361.2 2364.7 2309.6 2332.1 2371.5 2377.3 2382.8 2303.6 2316.4 2323.8 2370.7 2376.5 2262.6 2266.7 2276.9 2291.2 2297.6 2357.7 2357.8 2362.9 2381.0 2386.1 8826.9 8880.2 8913.2 8961.0 8970.5 5087.9 5142.3 5212.4 5291.0 5337.1 3210.8 3363.1 3394.5 3412.6 3423.7 1100.2 1164.3 1170.5 1195.8 1207.6 12352.8 12377.1 12413.6 12417.9 12425.7 4507.1 4593.6 4634.3 4668.5 4712.7 10345.4 10389.8 10453.2 10460.7 10471.2 5283.7 5285.5 5295.4 5310.2 5322.7 4244.4 4685.5 4788.2 4797.6 4863.0 4092.1 4112.3 4120.2 4131.5 4134.3 1298.9 1300.4 1321.4 1337.0 1358.6 789.2 928.9 953.9 996.7 1004.7 5768.7 5858.9 5921.2 6149.7 6239.2 1045.6 1051.5 1088.2 1099.7 1102.9 4038.9 4098.4 4106.8 4266.1 4270.0 10775.2 11110.0 11161.4 11173.5 11197.0 10086.5 10909.6 11007.3 11012.3 11031.9 8082.4 8399.5 8422.7 8426.6 8505.2 5938.4 5998.1 6060.8 6127.1 6233.2 9887.9 10155.6 10165.9 10208.4 10214.9 10316.5 10366.2 10591.5 10603.2 10637.5 8236.5 8422.2 8457.4 8576.2 8607.1 8432.0 8489.4 8498.0 8513.1 8527.7 7571.0 7683.0 7811.9 7905.8 7941.6 7672.0 7673.7 7693.6 7699.6 7933.2 7026.9 7089.2 7092.2 7125.4 7177.7 4854.6 5069.5 5167.0 5170.5 5323.1 5168.1 5203.8 5205.2 5211.4 5253.5 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | [#4] prototype.html Cycles:180 Average:4836.83 Median:5459.95 stddev:1442.71 (26.4%) stddev-sans-first:1406.38 14:28:25 INFO - PROCESS | 4134 | Values: 321.2 329.2 331.1 333.6 334.9 5478.4 5538.7 5565.6 5583.6 5588.6 5543.8 5545.9 5560.2 5568.6 5575.6 4316.9 4317.9 4326.4 4331.5 4346.1 4233.9 4259.2 4343.6 4350.4 4360.1 4265.9 4266.1 4268.2 4295.7 4303.2 4283.3 4295.7 4308.4 4325.2 4336.3 3767.2 3824.2 3861.6 3866.5 3872.4 5353.4 5375.2 5381.3 5399.9 5402.6 4895.1 4897.5 4910.9 4913.9 4916.1 5704.4 5776.8 5785.2 5812.5 5858.6 4173.8 4175.0 4178.2 4186.3 4202.7 5798.4 6094.0 6105.3 6109.5 6121.9 4163.0 4173.4 4174.6 4176.2 4194.6 4243.3 4245.2 4267.6 4272.3 4279.2 4814.3 4845.5 4891.7 4905.1 4923.8 5823.8 5831.4 5834.6 5852.8 5856.4 1442.5 1468.0 1476.6 1480.8 1483.8 887.4 944.6 945.2 947.9 956.8 5032.4 5049.0 5076.0 5113.5 5168.0 5288.6 5361.0 5398.9 5419.2 5478.3 4697.7 4993.4 5048.6 5058.0 5133.4 2879.5 2892.0 2900.9 2902.8 2908.8 5451.5 5460.8 5485.8 5525.8 5532.8 5459.1 5659.7 6191.7 6197.0 6221.9 6203.5 6231.7 6258.4 6265.2 6274.0 5964.3 5997.9 6076.9 6148.5 6160.3 5961.4 6053.7 6082.9 6095.7 6122.9 5921.8 6041.4 6154.4 6192.9 6220.4 4177.5 4197.7 4202.7 4208.6 4218.8 5837.0 6046.5 6060.9 6085.3 6130.3 5818.3 5898.3 5917.4 5940.2 5941.3 5806.2 5813.7 5900.4 5921.0 5938.5 5556.9 5651.4 5763.7 5777.8 5782.2 5926.5 5957.5 5968.1 5969.9 5990.2 5646.3 5760.7 5843.1 5843.6 5860.4 14:28:25 INFO - PROCESS | 4134 | 14:28:25 INFO - PROCESS | 4134 | [#5] yui.html Cycles:180 Average:20296.54 Median:4912.04 stddev:28905.77 (588.5%) stddev-sans-first:28949.40 14:28:25 INFO - PROCESS | 4134 | Values: 697.4 715.4 720.8 758.5 826.6 14114.5 14916.3 15002.2 15033.0 15072.7 14723.4 14827.4 14956.0 14972.2 14973.7 781.1 790.6 804.7 808.6 809.5 805.9 807.4 815.2 815.4 815.9 845.8 856.7 856.7 856.8 857.2 848.4 850.6 850.7 851.3 852.2 617.1 618.3 622.2 622.4 622.6 15782.4 15907.4 15909.5 15913.4 15923.5 14967.6 15105.9 15135.1 15151.7 15204.4 12511.2 12594.3 12607.3 12764.9 13376.9 3795.2 3827.6 3845.4 3884.7 3952.1 79261.6 79416.6 81879.0 82475.0 83054.6 11716.0 11721.7 11723.1 11835.3 12236.6 21515.5 21520.7 21552.0 21566.4 21590.4 8526.4 8917.3 8966.1 9115.1 9171.1 4824.0 4842.4 4981.7 5010.0 5087.0 3490.5 3614.0 3615.4 3631.5 3644.1 506.2 609.1 614.1 618.7 618.8 593.6 595.1 653.5 656.4 691.2 9052.9 9187.5 9235.5 9275.6 9482.5 608.3 674.3 696.4 712.2 713.9 4359.9 4379.1 4425.9 4494.7 4560.7 78919.6 104793.0 113091.0 121076.4 121169.4 64582.4 85701.6 93809.0 97751.5 97901.5 83851.7 83941.6 84087.2 85602.0 87511.0 8244.9 8256.8 8429.0 8469.3 8502.6 51219.2 51621.5 52055.2 52486.5 53884.0 71481.6 72694.0 73635.0 73672.0 74090.6 10430.7 10769.4 10837.9 10904.1 11182.8 12541.4 12826.2 12857.8 12935.4 13003.5 11324.9 11668.5 11712.2 11811.7 12306.6 12465.1 13460.8 13519.7 14088.6 14179.4 13949.2 13997.2 14004.2 14190.4 14590.1 10969.0 11398.1 11490.7 11936.0 12082.3 11383.3 11535.4 11910.7 11935.5 11976.9 14:28:25 INFO - PROCESS | 4134 | -------- Summary: end -------- 14:28:25 INFO - PROCESS | 4134 | 14:28:26 INFO - TEST-INFO | 4134: exit 0 14:28:26 INFO - TEST-OK | dromaeo_css | took 1110123ms 14:28:26 INFO - TEST-START | kraken 14:28:26 INFO - operating with platform_type : linux_ 14:28:26 INFO - Initialising browser for kraken test... 14:28:26 INFO - TEST-INFO | started process 4377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8CRfLl/profile http://localhost:43353/getInfo.html) 14:28:30 INFO - PROCESS | 4377 | __metrics Screen width/height:1600/1200 14:28:30 INFO - PROCESS | 4377 | colorDepth:24 14:28:30 INFO - PROCESS | 4377 | Browser inner width/height: 1024/697 14:28:30 INFO - PROCESS | 4377 | __metrics 14:28:31 ERROR - PROCESS | 4377 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 14:28:32 INFO - TEST-INFO | 4377: exit 0 14:28:32 INFO - Browser initialized. 14:28:32 INFO - Running cycle 1/1 for kraken test... 14:28:32 INFO - TEST-INFO | started process 4496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8CRfLl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:44 INFO - PROCESS | 4496 | RSS: Main: 167477248 14:28:44 INFO - PROCESS | 4496 | 14:28:46 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43353/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:47 INFO - PROCESS | 4496 | RSS: Main: 172650496 14:28:47 INFO - PROCESS | 4496 | 14:28:50 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43353/tests/kraken/driver.html?testName=audio-dft) 14:28:50 INFO - PROCESS | 4496 | RSS: Main: 172400640 14:28:50 INFO - PROCESS | 4496 | 14:28:53 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43353/tests/kraken/driver.html?testName=audio-fft) 14:28:54 INFO - PROCESS | 4496 | RSS: Main: 166858752 14:28:54 INFO - PROCESS | 4496 | 14:28:56 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43353/tests/kraken/driver.html?testName=audio-oscillator) 14:28:57 INFO - PROCESS | 4496 | RSS: Main: 167747584 14:28:57 INFO - PROCESS | 4496 | 14:28:59 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43353/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:59 INFO - PROCESS | 4496 | RSS: Main: 167989248 14:28:59 INFO - PROCESS | 4496 | 14:29:03 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43353/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:03 INFO - PROCESS | 4496 | RSS: Main: 167952384 14:29:03 INFO - PROCESS | 4496 | 14:29:07 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43353/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:07 INFO - PROCESS | 4496 | RSS: Main: 166227968 14:29:07 INFO - PROCESS | 4496 | 14:29:10 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43353/tests/kraken/driver.html?testName=json-parse-financial) 14:29:11 INFO - PROCESS | 4496 | RSS: Main: 167178240 14:29:11 INFO - PROCESS | 4496 | 14:29:12 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43353/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:13 INFO - PROCESS | 4496 | RSS: Main: 167763968 14:29:13 INFO - PROCESS | 4496 | 14:29:15 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:15 INFO - PROCESS | 4496 | RSS: Main: 167862272 14:29:15 INFO - PROCESS | 4496 | 14:29:17 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:18 INFO - PROCESS | 4496 | RSS: Main: 168083456 14:29:18 INFO - PROCESS | 4496 | 14:29:21 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:21 INFO - PROCESS | 4496 | RSS: Main: 168820736 14:29:21 INFO - PROCESS | 4496 | 14:29:24 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:25 INFO - PROCESS | 4496 | RSS: Main: 168718336 14:29:25 INFO - PROCESS | 4496 | 14:29:26 INFO - PROCESS | 4496 | Cycle 1(1): loaded http://localhost:43353/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43353/tests/kraken/driver.html?testName=ai-astar) 14:29:27 INFO - PROCESS | 4496 | RSS: Main: 169140224 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | __start_tp_report 14:29:27 INFO - PROCESS | 4496 | _x_x_mozilla_page_load 14:29:27 INFO - PROCESS | 4496 | _x_x_mozilla_page_load_details 14:29:27 INFO - PROCESS | 4496 | |i|pagename|runs| 14:29:27 INFO - PROCESS | 4496 | |0;ai-astar;112;105;111;112;112;115;112;110;113;110 14:29:27 INFO - PROCESS | 4496 | |1;audio-beat-detection;154;125;151;177;127;160;152;129;179;128 14:29:27 INFO - PROCESS | 4496 | |2;audio-dft;162;163;160;164;160;166;164;166;161;163 14:29:27 INFO - PROCESS | 4496 | |3;audio-fft;76;74;74;157;76;77;74;76;166;74 14:29:27 INFO - PROCESS | 4496 | |4;audio-oscillator;84;86;148;86;85;85;139;85;89;145 14:29:27 INFO - PROCESS | 4496 | |5;imaging-gaussian-blur;120;121;117;117;117;118;117;120;117;118 14:29:27 INFO - PROCESS | 4496 | |6;imaging-darkroom;146;147;151;148;151;147;147;146;147;147 14:29:27 INFO - PROCESS | 4496 | |7;imaging-desaturate;98;99;95;95;95;95;95;97;95;96 14:29:27 INFO - PROCESS | 4496 | |8;json-parse-financial;57;58;55;53;53;53;55;53;54;58 14:29:27 INFO - PROCESS | 4496 | |9;json-stringify-tinderbox;61;63;62;61;62;61;61;61;61;63 14:29:27 INFO - PROCESS | 4496 | |10;stanford-crypto-aes;78;82;80;79;80;79;86;79;106;81 14:29:27 INFO - PROCESS | 4496 | |11;stanford-crypto-ccm;123;134;136;124;125;122;124;125;133;126 14:29:27 INFO - PROCESS | 4496 | |12;stanford-crypto-pbkdf2;164;158;156;159;157;156;160;160;158;163 14:29:27 INFO - PROCESS | 4496 | |13;stanford-crypto-sha256-iterative;64;69;67;62;68;61;66;68;61;63 14:29:27 INFO - PROCESS | 4496 | __end_tp_report 14:29:27 INFO - PROCESS | 4496 | __start_cc_report 14:29:27 INFO - PROCESS | 4496 | _x_x_mozilla_cycle_collect,875 14:29:27 INFO - PROCESS | 4496 | __end_cc_report 14:29:27 INFO - PROCESS | 4496 | __startTimestamp1465421367084__endTimestamp 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | ------- Summary: start ------- 14:29:27 INFO - PROCESS | 4496 | Number of tests: 14 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.62 (2.3%) stddev-sans-first:2.76 14:29:27 INFO - PROCESS | 4496 | Values: 112.0 105.0 111.0 112.0 112.0 115.0 112.0 110.0 113.0 110.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:153.00 stddev:20.38 (13.3%) stddev-sans-first:21.51 14:29:27 INFO - PROCESS | 4496 | Values: 154.0 125.0 151.0 177.0 127.0 160.0 152.0 129.0 179.0 128.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.50 stddev:2.18 (1.3%) stddev-sans-first:2.29 14:29:27 INFO - PROCESS | 4496 | Values: 162.0 163.0 160.0 164.0 160.0 166.0 164.0 166.0 161.0 163.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.50 (48.7%) stddev-sans-first:38.23 14:29:27 INFO - PROCESS | 4496 | Values: 76.0 74.0 74.0 157.0 76.0 77.0 74.0 76.0 166.0 74.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:85.00 stddev:28.27 (33.3%) stddev-sans-first:29.12 14:29:27 INFO - PROCESS | 4496 | Values: 84.0 86.0 148.0 86.0 85.0 85.0 139.0 85.0 89.0 145.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.55 (1.3%) stddev-sans-first:1.50 14:29:27 INFO - PROCESS | 4496 | Values: 120.0 121.0 117.0 117.0 117.0 118.0 117.0 120.0 117.0 118.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:1.83 (1.2%) stddev-sans-first:1.83 14:29:27 INFO - PROCESS | 4496 | Values: 146.0 147.0 151.0 148.0 151.0 147.0 147.0 146.0 147.0 147.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.50 stddev:1.49 (1.6%) stddev-sans-first:1.39 14:29:27 INFO - PROCESS | 4496 | Values: 98.0 99.0 95.0 95.0 95.0 95.0 95.0 97.0 95.0 96.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:2.08 (3.8%) stddev-sans-first:2.06 14:29:27 INFO - PROCESS | 4496 | Values: 57.0 58.0 55.0 53.0 53.0 53.0 55.0 53.0 54.0 58.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 14:29:27 INFO - PROCESS | 4496 | Values: 61.0 63.0 62.0 61.0 62.0 61.0 61.0 61.0 61.0 63.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:80.00 stddev:8.39 (10.5%) stddev-sans-first:8.71 14:29:27 INFO - PROCESS | 4496 | Values: 78.0 82.0 80.0 79.0 80.0 79.0 86.0 79.0 106.0 81.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:125.50 stddev:5.09 (4.1%) stddev-sans-first:5.17 14:29:27 INFO - PROCESS | 4496 | Values: 123.0 134.0 136.0 124.0 125.0 122.0 124.0 125.0 133.0 126.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:159.50 stddev:2.73 (1.7%) stddev-sans-first:2.24 14:29:27 INFO - PROCESS | 4496 | Values: 164.0 158.0 156.0 159.0 157.0 156.0 160.0 160.0 158.0 163.0 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - PROCESS | 4496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:66.50 stddev:3.07 (4.6%) stddev-sans-first:3.24 14:29:27 INFO - PROCESS | 4496 | Values: 64.0 69.0 67.0 62.0 68.0 61.0 66.0 68.0 61.0 63.0 14:29:27 INFO - PROCESS | 4496 | -------- Summary: end -------- 14:29:27 INFO - PROCESS | 4496 | 14:29:27 INFO - TEST-INFO | 4496: exit 0 14:29:28 INFO - TEST-OK | kraken | took 61759ms 14:29:28 INFO - SUITE-END | took 1171s 14:29:28 INFO - Completed test suite (00:19:32) 14:29:28 INFO - javascript benchmark 14:29:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7201.617461781055, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3177.158053115924, 3179.761517886158, 3183.5065564837428, 3219.597550306212, 3223.854926528306, 5336.573074154068, 5441.347038355398, 5457.590680698949, 5525.585581081415, 5525.613207075507, 5406.08096623574, 5515.034868897937, 5517.200005999128, 5536.446355364462, 5593.356763972144, 5028.8239911603105, 5073.3404657394485, 5116.488351164872, 5148.279240906276, 5189.896202075956, 743.5089328402628, 4926.211806111023, 4936.629752768539, 5094.235864620318, 5099.235114732801, 4988.152014157566, 4996.350474438336, 5044.646874718789, 5053.0, 5096.541311281984, 4988.201887697951, 4989.126902792033, 5011.799528018875, 5055.064813009605, 5059.74701264939, 4924.729139897304, 4928.334674818925, 4931.7780699868235, 4965.23038928963, 4996.2755400467095, 5378.569714422837, 5380.112281473552, 5388.865278368033, 5401.378841433207, 5409.134538473825, 5775.5957083004205, 5848.7075646217945, 5862.163714935153, 5872.5889187756875, 5907.763689452417, 5788.04497257952, 5855.912161317584, 5891.617044892068, 5899.5280377570125, 5963.314218864799, 5542.501174894279, 5547.750351234205, 5553.7778488860395, 5556.805511807108, 5560.582956278296, 5908.231929849092, 6024.3975602439405, 6033.064874944391, 6037.818865434044, 6048.0625503047095, 5744.569157313218, 5827.125931110368, 5876.265466816648, 5900.055991041413, 5915.585908986416, 5982.282126144891, 6020.638761674313, 6029.909551356734, 6032.788852390146, 6034.607750496204, 5781.277340332458, 5929.644221346733, 5994.460498555064, 6011.549133814981, 6020.127081573148, 5783.277090363705, 5818.592698511148, 5839.941600583939, 5869.765209391662, 5874.236349274653, 4415.2935530315, 4419.624331931757, 4435.578620031092, 4457.799399027052, 4479.148961697267, 3919.392494163409, 3922.5489068756888, 3925.8822235332987, 3970.622790834866, 3981.8606348778235, 5462.180672899018, 5540.63985840919, 5553.222548843165, 5561.416051314553, 5616.269884914935, 5802.361740208574, 5890.028145356054, 5914.408559144051, 5922.082077278029, 5932.110183472513, 5580.91628625571, 5599.300087489064, 5630.971845140748, 5642.492175704207, 5643.435656434323, 5024.673396229234, 5061.291419201241, 5063.367079115111, 5129.12804823181, 5134.306868572769, 5977.850553736192, 6025.487833534111, 6029.186059881859, 6072.180255665517, 6081.391860813883, 5778.56660750437, 5825.825225243249, 5897.970510147507, 5945.791897283574, 5967.701614919323, 5919.348871624204, 5933.258342707161, 5967.134765458897, 6078.118672792509, 6120.296165940974, 5802.245708057925, 5853.239078919713, 5858.326292476419, 5869.266341707286, 5883.352831188651, 5871.6770577618645, 5990.7304171311525, 5996.070609055603, 5998.610090344114, 6001.879962400815, 5778.595498315078, 5813.970930145322, 5838.12428135783, 5842.766289348378, 5880.970595146997, 5816.563757718272, 5833.708314584339, 5834.15404766315, 5842.941570584239, 5843.912341314799, 5441.700706461183, 5479.205515200353, 5663.830085097454, 5687.715614219355, 5701.486866182064, 5685.488306052475, 5702.7718891243885, 5756.625819321731, 5756.971215143897, 5770.6249093808765, 5576.7211639417055, 5578.0, 5579.637323573955, 5585.0, 5585.497305242385], "value": 5395.909358030656, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3296377311, 599.0385431382631, 618.6350053468458, 619.2383368456799, 629.3611983836407, 41609.58390416095, 42875.14249715012, 43020.78489607555, 43122.35316470255, 46148.769256153675, 44507.33239001418, 44805.55194448055, 45231.77384113083, 45272.54727452724, 45344.3198352025, 8666.91333086669, 8825.161609647073, 8831.95584022079, 8840.425372350808, 8860.379773415863, 8570.142985701443, 8705.434146780439, 8746.125387461267, 8765.868511972325, 8789.64841406343, 8720.0, 8790.252828509585, 8799.032106468283, 8839.867401988975, 8845.0, 8607.268382187522, 8696.956515217384, 8698.0, 8710.346723995663, 8798.47209167452, 8714.041455439896, 8720.171583699603, 8800.515971621558, 8805.559722013873, 8814.382993190478, 41038.794806026075, 41238.587614123775, 41495.37756933648, 41607.37588936168, 41706.0, 3631.6186800385844, 3680.4479328100733, 3736.8878933631763, 4022.4368588397647, 4057.3508238681966, 31709.0, 31736.36527269465, 31952.0, 32208.194795130075, 32423.675763242303, 4150.481189851269, 4179.832806687759, 4242.406063151161, 4253.447051883235, 4350.260455722503, 331332.0, 331350.0, 331906.0, 335279.32360338286, 335493.0, 33392.83303583515, 56605.716971415706, 56793.43206567964, 56878.14682779762, 56893.0, 34039.489407658904, 35823.64176358203, 35913.64086359103, 36106.27787444289, 36207.63792362042, 15171.620709482351, 15254.771178432333, 15350.07899526032, 15359.462418815288, 15397.538073857802, 12840.807387889188, 12934.0, 13013.154144980546, 13027.283499407624, 13043.217406955613, 8310.958445207736, 8321.126281740451, 8331.37514686401, 8375.288100511403, 8400.453970491899, 3201.743860491155, 3203.0, 3205.3909757146066, 3270.084376374619, 3319.286353434023, 1008.4856723071287, 1046.3355769086684, 1084.6203828660064, 1088.874779400379, 1118.3513562133942, 31370.52944205839, 32130.0, 32186.517202241987, 32464.0, 32498.35003299921, 1107.1087774341572, 1111.2054880760295, 1157.4155051698838, 1179.870214276429, 1212.6422705301957, 16207.0, 16635.50093497197, 16707.164641768108, 16726.581835453966, 17006.829931700773, 538686.0, 546798.0, 547869.0, 549270.0, 554331.0, 55726.16410753842, 57332.0, 57393.71303143458, 57512.712436438385, 57607.42392576021, 1347.3061373392711, 1364.6520137364907, 1381.5717127690448, 1394.4073768648284, 1398.5105213175307, 29297.70702293035, 30494.237644059074, 30558.236044099074, 30699.0, 30803.84598076995, 48505.5149448501, 48929.2660610084, 49115.75442122766, 49202.0, 49352.50647493479, 435374.0, 446486.0, 446954.0, 447111.0, 447898.0, 27424.0, 27507.0, 27547.31131721723, 27593.310167245978, 27643.0, 45897.54102458933, 46285.0, 47303.925244858976, 47645.76177119092, 48006.279905800744, 39803.60196397999, 40054.39918401168, 40520.71289023601, 41162.79418602888, 41571.0, 39051.80474097611, 39335.40996885106, 39787.60212397839, 39863.0, 40040.799796000836, 39426.80286598549, 39628.40557391699, 39923.60076399199, 40373.798131009156, 40695.0, 34131.48802767911, 36801.26397472089, 37164.25671486609, 37295.44056839095, 37899.24201515899, 27789.58315625227, 28111.71888281091, 28153.0, 28288.71711282861, 28619.855205791537], "value": 18776.763680754986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5539174557514, 384.8691444908731, 388.10721584656494, 391.63773509503704, 410.2758631016257, 17457.563560910967, 18809.529761755963, 19010.904945475253, 19220.519487012833, 19839.801601983974, 18685.626287474242, 18922.90538547309, 19276.421707348767, 19430.611387772235, 19491.317803876867, 5455.427180146087, 5482.780688772445, 5606.187102870082, 5612.709076912312, 5662.094064949609, 5522.779088836442, 5548.58385621078, 5559.805406810762, 5577.8047768328115, 5594.049011668027, 5284.894302113956, 5525.778968841241, 5548.55611551075, 5552.3892371839065, 5557.805476808313, 5429.619926605139, 5562.99999999998, 5581.5255703265475, 5628.746706398201, 5760.855978600569, 5598.748056337434, 5600.52395546379, 5627.746751396197, 5638.492535671769, 5662.235598194232, 13396.93301533486, 16120.838791612052, 20934.325253979645, 22243.888780556157, 22266.777332226633, 2182.8430931606117, 2207.635740102897, 2217.434554188688, 2236.9888150559304, 2275.328778010491, 9961.153301969342, 10163.441010744406, 10263.538140783608, 10487.161027117812, 10500.0, 1937.4962509747427, 1964.2044971786306, 1978.3570339639675, 1986.255154317131, 2027.2701827342146, 74641.0, 75554.24445755527, 76241.61879190624, 76885.61557192178, 77420.22579774186, 10617.893821061845, 10808.94595527033, 11451.312921224753, 11632.592859250055, 11839.88160118405, 15010.849891501164, 15061.698766024618, 15173.393064277527, 15249.695006099815, 15272.618184545254, 8028.237317454949, 8243.793905152299, 8289.41974061822, 8314.376421768391, 8409.621567029377, 7186.892196617055, 7246.492745507764, 7344.706211751577, 7346.265373462611, 7776.766696999099, 4581.885452863705, 4608.0, 4615.538446155425, 4629.768511574408, 4691.601213896789, 1902.4482899958857, 1937.5349916020054, 1937.6705959986837, 1938.457231975021, 1971.5662554238045, 903.2773780975193, 981.6858605246252, 982.5676702250987, 1006.5571148694551, 1043.0508237503834, 17983.73024404635, 18280.360187393377, 18553.165107570192, 18878.52803679919, 19002.144903479377, 1004.1163775877327, 1018.6943916824923, 1038.4496217004998, 1046.9005444482762, 1096.4188979840696, 9387.009324448998, 10459.320144190755, 10493.317934334396, 10618.946905265579, 10628.415437150876, 460965.0, 469777.0, 481308.0, 482146.0, 482837.0, 95252.52373738226, 96907.51546242223, 97081.514592428, 97170.0, 97234.51382743183, 1001.6494227020485, 1023.3808545829665, 1043.660810236676, 1045.487711021594, 1049.7218237167158, 16248.837511624732, 16744.41394551185, 16835.66328673395, 17014.14929253557, 17095.48713538596, 28648.0, 37166.62833371632, 43254.78372608242, 43394.0, 45088.774556127006, 58053.709731451076, 58872.705636471546, 59458.0, 59822.102668459134, 60359.0, 7309.378702810108, 7603.885941710768, 8117.675292988214, 8432.156784321518, 8694.739157825023, 12434.129610927148, 12760.234385936874, 12894.29081400532, 13238.867611324149, 13263.137896036727, 11013.889861101286, 11337.943310283395, 11397.202195846543, 11544.076473882238, 11593.768124637292, 11387.43062846871, 11440.542378304775, 11453.713657158305, 11522.76954460923, 11647.708807279885, 11018.44907754593, 11344.20590558653, 11486.82769758471, 11664.533418663159, 11941.223820451643, 7752.728654497066, 7867.252611001945, 7931.881021784793, 7957.1644977276555, 7989.920100798918, 9801.607935682492, 11354.659360219206, 11369.602063927723, 11525.308481491138, 11600.825987610362], "value": 9008.462644650728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1462.064278861529, 1501.294391635931, 1596.146061856906, 1728.6888360095177, 1756.279925230654, 7881.92118078819, 8555.0, 8588.227059564639, 9096.272298216143, 9098.772530686729, 8655.0, 8914.86627700585, 8964.058773828752, 8994.595243214055, 9005.819883602324, 2331.0675729708123, 2339.7426283108844, 2350.3066595354326, 2361.244401791427, 2364.6689463475127, 2309.595820731374, 2332.0904847109555, 2371.4782747795457, 2377.2749311459997, 2382.809375249976, 2303.6314189729646, 2316.363000174957, 2323.825713071518, 2370.739218685952, 2376.5484557934024, 2262.592733308004, 2266.7166604174477, 2276.8747718875456, 2291.163725240284, 2297.574948634508, 2357.6934998450265, 2357.7642235776457, 2362.9409264768346, 2381.047580967627, 2386.069432921162, 8826.86759698605, 8880.1563851434, 8913.242374398184, 8961.014288428267, 8970.50662213578, 5087.949120508822, 5142.30578871855, 5212.4266330703595, 5290.973545132289, 5337.06601344767, 3210.7752457327997, 3363.1087761743156, 3394.541736865516, 3412.5563676721868, 3423.6747508986605, 1100.2023532938636, 1164.2723297938787, 1170.5142365918134, 1195.8206269059624, 1207.6135636596293, 12352.814707779391, 12377.071719621064, 12413.627591172279, 12417.93791031048, 12425.689357766038, 4507.143642707875, 4593.632509399307, 4634.304854271886, 4668.50980647034, 4712.69367491112, 10345.431001295, 10389.84415233757, 10453.163746900229, 10460.68617941463, 10471.214658900613, 5283.735813209324, 5285.493634314202, 5295.4439783822145, 5310.176922577007, 5322.654027488201, 4244.427002354704, 4685.461171965199, 4788.233882578771, 4797.64017698674, 4862.975685121552, 4092.0792821615496, 4112.3420252759415, 4120.157175998373, 4131.5248746393945, 4134.297169481196, 1298.8506321773118, 1300.408314217048, 1321.378951892609, 1336.9933150334186, 1358.585631382438, 789.2344425906975, 928.9038934057742, 953.8950715421298, 996.6611352140162, 1004.7036124343336, 5768.711564421762, 5858.945389829872, 5921.2302400688495, 6149.723262453201, 6239.188905442264, 1045.5869931377215, 1051.5163025008583, 1088.2327958789035, 1099.7360633447915, 1102.895224953628, 4038.8788336349958, 4098.446709694213, 4106.835726570904, 4266.146770645883, 4269.978650106729, 10775.191860610486, 11110.0, 11161.386123763108, 11173.497192626352, 11197.0, 10086.546105425274, 10909.563617455371, 11007.284526505911, 11012.339259644446, 11031.944840275748, 8082.353411727047, 8399.538025408661, 8422.663093476192, 8426.578671066545, 8505.23452889243, 5938.376470470538, 5998.1002849572915, 6060.787872424444, 6127.080937859357, 6233.2208473940755, 9887.85168222463, 10155.593776248867, 10165.898341016495, 10208.438535880598, 10214.897851021691, 10316.535755891153, 10366.170706343626, 10591.4704264788, 10603.204759642904, 10637.468126593794, 8236.50580965144, 8422.199891010345, 8457.40798144124, 8576.228139467477, 8607.139286071342, 8431.957840211006, 8489.405741598275, 8498.02272738643, 8513.063563008189, 8527.701530446404, 7571.0, 7683.039620047494, 7811.921880781119, 7905.762827115196, 7941.6029198541, 7672.0409948756405, 7673.693052278069, 7693.615319234128, 7699.576523291273, 7933.206679332251, 7026.929730702627, 7089.184743754328, 7092.184398793998, 7125.394341480825, 7177.672130655846, 4854.5873600744335, 5069.543741063322, 5166.974165129301, 5170.482951704799, 5323.148296272578, 5168.095583272988, 5203.765830537559, 5205.245239440335, 5211.426743058337, 5253.50091741284], "value": 4710.092905851307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.2178345728151, 329.1901921273667, 331.14729571353763, 333.57968959111525, 334.9464085746281, 5478.424765399631, 5538.695371754552, 5565.554755619551, 5583.637063590863, 5588.552915766739, 5543.835794483153, 5545.889082218353, 5560.193771903072, 5568.605499635155, 5575.609707320489, 4316.870493885189, 4317.913641727164, 4326.43756311679, 4331.45856767904, 4346.109047645241, 4233.915321693565, 4259.190753756776, 4343.565643435647, 4350.36919646651, 4360.127974405116, 4265.893352666177, 4266.146770645883, 4268.167707297078, 4295.72077814941, 4303.203907277164, 4283.3146696528565, 4295.72077814941, 4308.418363520932, 4325.15659446405, 4336.349547567858, 3767.2465506898457, 3824.158685089276, 3861.613838616144, 3866.5360156781367, 3872.4191371294532, 5353.357597088374, 5375.22059301403, 5381.300430943952, 5399.865003374908, 5402.567794576464, 4895.143349913787, 4897.461279259279, 4910.895048614069, 4913.852584422437, 4916.139675556799, 5704.401037891044, 5776.797812076599, 5785.247917770705, 5812.534997200214, 5858.648481091105, 4173.812178451977, 4174.958250417518, 4178.247915375231, 4186.28833098371, 4202.747835129902, 5798.449147330997, 6093.96953015241, 6105.32841387447, 6109.541784366191, 6121.938780612226, 4163.0, 4173.353130264753, 4174.624283814472, 4176.248275310412, 4194.601512856274, 4243.342281946303, 4245.150969806051, 4267.615914567642, 4272.316429371285, 4279.229738647011, 4814.301926220748, 4845.491223421561, 4891.6575839691595, 4905.141600219948, 4923.827666031743, 5823.825285241365, 5831.358550559435, 5834.5624078194305, 5852.795152169739, 5856.355800861902, 1442.4590778458078, 1467.955961321162, 1476.6308422894276, 1480.8000919875894, 1483.7700156475764, 887.3522328700085, 944.6127087894068, 945.2013048973606, 947.928905332089, 956.8086382723483, 5032.396112466454, 5048.974755126201, 5076.035553244872, 5113.51421614946, 5168.0, 5288.603354748409, 5360.989628889167, 5398.91901621476, 5419.187121931663, 5478.260869565217, 4697.6711630185555, 4993.350864387679, 5048.570871475892, 5058.0, 5133.383993920679, 2879.467298549775, 2891.956620650692, 2900.9258380258216, 2902.8258304501796, 2908.7672986161056, 5451.454854514596, 5460.754266058037, 5485.780568777204, 5525.76206636313, 5532.7786888524815, 5459.143891077053, 5659.717014149276, 6191.690415479208, 6196.969015154896, 6221.875562488724, 6203.503719702413, 6231.657258850807, 6258.436740693269, 6265.248170219512, 6274.027525733519, 5964.300174450261, 5997.860406522746, 6076.900780601836, 6148.538859585459, 6160.33670908861, 5961.433663801932, 6053.668192997534, 6082.878342433038, 6095.695215239131, 6122.938770612237, 5921.822345329475, 6041.365656605993, 6154.415330543591, 6192.876142477216, 6220.413794482559, 4177.540470548298, 4197.685173611931, 4202.663786897102, 4208.579142085767, 4218.81015354316, 5836.970815145897, 6046.486048685911, 6060.939390606038, 6085.269767627913, 6130.325664177026, 5818.301803783573, 5898.262717160355, 5917.408259174048, 5940.227770389822, 5941.287045554561, 5806.187133801355, 5813.680247586423, 5900.409959004237, 5921.0, 5938.524918006463, 5556.888862222814, 5651.378348381592, 5763.682997435014, 5777.768889244383, 5782.190493330853, 5926.4666180044005, 5957.523398128226, 5968.060380376482, 5969.910451343147, 5990.1913241713555, 5646.322441307069, 5760.740766665426, 5843.094320380348, 5843.649381037151, 5860.38465961068], "value": 4370.267546509284, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.4315932515, 715.3633266392908, 720.8378114924141, 758.4652819762068, 826.6280173921734, 14114.505992290271, 14916.254187290619, 15002.174880381575, 15033.022853514527, 15072.6985460291, 14723.411063557473, 14827.406903723864, 14956.0, 14972.17653029083, 14973.700525989474, 781.0705260739716, 790.5849429049738, 804.6660635836121, 808.5512540539997, 809.4697972827807, 805.8630032894422, 807.410590269101, 815.2377527012233, 815.4088285992667, 815.9184081591823, 845.8350621628784, 856.6787454704486, 856.7001549457672, 856.7686724584389, 857.1856736100698, 848.4273115646976, 850.5789634131145, 850.6639877248483, 851.2551517422255, 852.1521086518923, 617.077469183569, 618.3167599802199, 622.1631905087695, 622.4335854372499, 622.6357580815229, 15782.368705251776, 15907.443239486678, 15909.52271431859, 15913.363465461367, 15923.52229433119, 14967.550973470814, 15105.924470377578, 15135.091894486366, 15151.696966060617, 15204.391824327015, 12511.249325040526, 12594.307313097775, 12607.306598137098, 12764.936175319064, 13376.933115334361, 3795.2409518096492, 3827.598897874323, 3845.4231865220163, 3884.7280690351686, 3952.051507638146, 79261.60369198174, 79416.60291698562, 81879.0, 82475.0, 83054.58472707658, 11716.0, 11721.706957326134, 11723.120765942589, 11835.349055802013, 12236.632901012983, 21515.462113447287, 21520.677189842165, 21552.0, 21566.353009409744, 21590.352289431343, 8526.360522960678, 8917.28661707075, 8966.148215919608, 9115.134062264075, 9171.082891710908, 4823.95176048235, 4842.394700662418, 4981.676191047571, 5010.023045506165, 5087.033463641897, 3490.47642853574, 3614.0, 3615.439606860941, 3631.455281707712, 3644.0889777555612, 506.17493485618206, 609.0985341694317, 614.0574218574467, 618.730852079347, 618.8267285160163, 593.6289818863211, 595.0627761276007, 653.5491209514869, 656.3567703650449, 691.2223748283182, 9052.8642070369, 9187.540622968825, 9235.492047937294, 9275.58259878307, 9482.525873706425, 608.2913405882186, 674.2650510942998, 696.3663066609361, 712.2272334517004, 713.9000539924415, 4359.912801744011, 4379.1460665170625, 4425.889352766207, 4494.685372023992, 4560.703554268962, 78919.60540197263, 104793.0, 113091.0, 121076.39461802634, 121169.39415303043, 64582.354176458575, 85701.57149214338, 93809.0, 97751.51124244333, 97901.5104924485, 83851.74222386669, 83941.58029209815, 84087.15912840793, 85602.0, 87511.0, 8244.876326854983, 8256.752297431087, 8429.008135262517, 8469.280111190617, 8502.617382217692, 51219.2317115251, 51621.48378516167, 52055.219171711695, 52486.47513524816, 53884.0, 71481.6425917867, 72694.0, 73635.0, 73672.0, 74090.62954685408, 10430.68707938763, 10769.353838769699, 10837.945810270898, 10904.127669786556, 11182.776344472903, 12541.372931353213, 12826.166299190523, 12857.807132893202, 12935.353232338533, 13003.544875929298, 11324.94337528307, 11668.533258669559, 11712.180147389601, 11811.704707382385, 12306.569270075863, 12465.127441079037, 13460.798088028883, 13519.729605408034, 14088.577342679737, 14179.361928713026, 13949.16305021702, 13997.160170389809, 14004.229767362893, 14190.361433735301, 14590.124592524482, 10969.0, 11398.08815294758, 11490.655280341603, 11936.0, 12082.33547154915, 11383.260088094248, 11535.36555489456, 11910.707076748296, 11935.462904169159, 11976.880231197576], "value": 7424.4906880885455, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 112.0, 112.0, 115.0, 112.0, 110.0, 113.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 151.0, 177.0, 127.0, 160.0, 152.0, 129.0, 179.0, 128.0], "value": 148.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 160.0, 164.0, 160.0, 166.0, 164.0, 166.0, 161.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 74.0, 157.0, 76.0, 77.0, 74.0, 76.0, 166.0, 74.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 148.0, 86.0, 85.0, 85.0, 139.0, 85.0, 89.0, 145.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 117.0, 117.0, 117.0, 118.0, 117.0, 120.0, 117.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 151.0, 148.0, 151.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 55.0, 53.0, 53.0, 53.0, 55.0, 53.0, 54.0, 58.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 63.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 80.0, 79.0, 80.0, 79.0, 86.0, 79.0, 106.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 134.0, 136.0, 124.0, 125.0, 122.0, 124.0, 125.0, 133.0, 126.0], "value": 127.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 158.0, 156.0, 159.0, 157.0, 156.0, 160.0, 160.0, 158.0, 163.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 67.0, 62.0, 68.0, 61.0, 66.0, 68.0, 61.0, 63.0], "value": 64.9, "unit": "score"}]}]} 14:29:28 INFO - Return code: 0 14:29:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:28 ERROR - # TBPL SUCCESS # 14:29:28 INFO - Running post-action listener: _resource_record_post_action 14:29:28 INFO - ##### 14:29:28 INFO - ##### Finished run-tests step (success) 14:29:28 INFO - ##### 14:29:28 INFO - Running post-run listener: _resource_record_post_run 14:29:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 462848; Write bytes: 367013888; Read time: 112; Write time: 309816 14:29:28 INFO - TinderboxPrint: CPU usage
13.4% 14:29:28 INFO - TinderboxPrint: I/O read bytes / time
462,848 / 112 14:29:28 INFO - TinderboxPrint: I/O write bytes / time
367,013,888 / 309,816 14:29:28 INFO - TinderboxPrint: CPU idle
8,220.8 (86.6%) 14:29:28 INFO - TinderboxPrint: CPU user
1,220.3 (12.9%) 14:29:28 INFO - TinderboxPrint: Swap in / out
0 / 0 14:29:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 76713984; Read time: 0; Write time: 61572 14:29:28 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 462848; Write bytes: 290299904; Read time: 112; Write time: 248244 14:29:29 INFO - Running post-run listener: _upload_blobber_files 14:29:29 INFO - Blob upload gear active. 14:29:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:29 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 14:29:29 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'] 14:29:29 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 14:29:29 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:30 INFO - (blobuploader) - INFO - Done attempting. 14:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:31 INFO - (blobuploader) - INFO - Done attempting. 14:29:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:34 INFO - (blobuploader) - INFO - Done attempting. 14:29:34 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:34 INFO - Return code: 0 14:29:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3621980298a7cee04c99c038abfa680c0b0b04dbcbfb522b779df03885009b5b158e768a999279a00d7c86487794a7258563e3527c445eccc8f0c4bf8e1c5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284965f242e23d456b9a0fb234cd58fea7c1bf0352268105bd5b0d9b55cc871f726cfdebe05ad2bb8507a6297840efd918c0e2e6d33b48dfb937b3ad801868f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d65fdf60ca1a2236cdfaef5dd0b38260fb0d12da6a551bfb28d09b4db086dccbee7c9e6b444e5b2112aa28fcd454cab830054f8cc883761ebef03dc0f8c9a00"} 14:29:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:34 INFO - Contents: 14:29:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3621980298a7cee04c99c038abfa680c0b0b04dbcbfb522b779df03885009b5b158e768a999279a00d7c86487794a7258563e3527c445eccc8f0c4bf8e1c5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284965f242e23d456b9a0fb234cd58fea7c1bf0352268105bd5b0d9b55cc871f726cfdebe05ad2bb8507a6297840efd918c0e2e6d33b48dfb937b3ad801868f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d65fdf60ca1a2236cdfaef5dd0b38260fb0d12da6a551bfb28d09b4db086dccbee7c9e6b444e5b2112aa28fcd454cab830054f8cc883761ebef03dc0f8c9a00"} 14:29:34 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:34 INFO - Copying logs to upload dir... 14:29:34 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.374051 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-08 14:29:34.956472) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:34.959958) ========= 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=7de08804244eb36560b44971000001c3-1465420072.647511-1494502784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3621980298a7cee04c99c038abfa680c0b0b04dbcbfb522b779df03885009b5b158e768a999279a00d7c86487794a7258563e3527c445eccc8f0c4bf8e1c5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284965f242e23d456b9a0fb234cd58fea7c1bf0352268105bd5b0d9b55cc871f726cfdebe05ad2bb8507a6297840efd918c0e2e6d33b48dfb937b3ad801868f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d65fdf60ca1a2236cdfaef5dd0b38260fb0d12da6a551bfb28d09b4db086dccbee7c9e6b444e5b2112aa28fcd454cab830054f8cc883761ebef03dc0f8c9a00"} build_url:https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/Qvjpv1w-RuuwPYwyr_LI9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3621980298a7cee04c99c038abfa680c0b0b04dbcbfb522b779df03885009b5b158e768a999279a00d7c86487794a7258563e3527c445eccc8f0c4bf8e1c5ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/284965f242e23d456b9a0fb234cd58fea7c1bf0352268105bd5b0d9b55cc871f726cfdebe05ad2bb8507a6297840efd918c0e2e6d33b48dfb937b3ad801868f9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d65fdf60ca1a2236cdfaef5dd0b38260fb0d12da6a551bfb28d09b4db086dccbee7c9e6b444e5b2112aa28fcd454cab830054f8cc883761ebef03dc0f8c9a00"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:34.988212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:34.988872) ========= 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=7de08804244eb36560b44971000001c3-1465420072.647511-1494502784 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004478 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 14:29:35.070443) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 14:29:35.070794) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-08 14:29:35.071116) ========= ========= Total master_lag: 0.20 =========