builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1466180603.99 results: success (0) buildid: 20160617062337 builduid: d6c13d86140e4680b93364e2a96ef394 revision: 535a13bd2bf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:23.985872) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:23.986313) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:23.986612) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:24.001443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:24.001804) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-17 09:23:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.1M=0s 2016-06-17 09:23:24 (40.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.346255 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:24.361788) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:24.362100) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020039 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:24.412436) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:24.412920) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 535a13bd2bf9 --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 535a13bd2bf9 --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=a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-17 09:23:24,635 Setting DEBUG logging. 2016-06-17 09:23:24,635 attempt 1/10 2016-06-17 09:23:24,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/535a13bd2bf9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-17 09:23:24,937 unpacking tar archive at: fx-team-535a13bd2bf9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657157 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:25.086306) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:25.086850) ========= script_repo_revision: 535a13bd2bf9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:25.087489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:25.087932) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-17 09:23:25.100381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-17 09:23:25.100964) ========= /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=a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:25 INFO - MultiFileLogger online at 20160617 09:23:25 in /builds/slave/test 09:23:25 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 09:23:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:25 INFO - {'append_to_log': False, 09:23:25 INFO - 'base_work_dir': '/builds/slave/test', 09:23:25 INFO - 'blob_upload_branch': 'Fx-Team', 09:23:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:25 INFO - 'branch': 'Fx-Team', 09:23:25 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:25 INFO - 'config_files': ('talos/linux_config.py',), 09:23:25 INFO - 'default_actions': ('clobber', 09:23:25 INFO - 'read-buildbot-config', 09:23:25 INFO - 'download-and-extract', 09:23:25 INFO - 'populate-webroot', 09:23:25 INFO - 'create-virtualenv', 09:23:25 INFO - 'install', 09:23:25 INFO - 'run-tests'), 09:23:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:25 INFO - 'download_minidump_stackwalk': True, 09:23:25 INFO - 'download_symbols': 'ondemand', 09:23:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:25 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:25 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:25 INFO - 'installer_path': 'installer.exe', 09:23:25 INFO - 'log_level': 'info', 09:23:25 INFO - 'log_name': 'talos', 09:23:25 INFO - 'log_to_console': True, 09:23:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:25 INFO - 'opt_config_files': (), 09:23:25 INFO - 'pip_index': False, 09:23:25 INFO - 'sps_profile': False, 09:23:25 INFO - 'sps_profile_interval': 0, 09:23:25 INFO - 'suite': 'dromaeojs-e10s', 09:23:25 INFO - 'system_bits': '32', 09:23:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:25 INFO - 'title': 'talos-linux64-ix-002', 09:23:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:25 INFO - 'use_talos_json': True, 09:23:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:25 INFO - 'work_dir': 'build'} 09:23:25 INFO - ##### 09:23:25 INFO - ##### Running clobber step. 09:23:25 INFO - ##### 09:23:25 INFO - Running pre-action listener: _resource_record_pre_action 09:23:25 INFO - Running main action method: clobber 09:23:25 INFO - rmtree: /builds/slave/test/build 09:23:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:25 INFO - Running post-action listener: _resource_record_post_action 09:23:25 INFO - ##### 09:23:25 INFO - ##### Finished clobber step (success) 09:23:25 INFO - ##### 09:23:25 INFO - ##### 09:23:25 INFO - ##### Running read-buildbot-config step. 09:23:25 INFO - ##### 09:23:25 INFO - Running pre-action listener: _resource_record_pre_action 09:23:25 INFO - Running main action method: read_buildbot_config 09:23:25 INFO - Using buildbot properties: 09:23:25 INFO - { 09:23:25 INFO - "project": "", 09:23:25 INFO - "product": "firefox", 09:23:25 INFO - "script_repo_revision": "production", 09:23:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:23:25 INFO - "repository": "", 09:23:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 09:23:25 INFO - "buildid": "20160617062337", 09:23:25 INFO - "pgo_build": "True", 09:23:25 INFO - "basedir": "/builds/slave/test", 09:23:25 INFO - "buildnumber": 839, 09:23:25 INFO - "slavename": "talos-linux64-ix-002", 09:23:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:23:25 INFO - "platform": "ubuntu64_hw", 09:23:25 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:23:25 INFO - "branch": "fx-team", 09:23:25 INFO - "repo_path": "integration/fx-team", 09:23:25 INFO - "revision": "535a13bd2bf9", 09:23:25 INFO - "stage_platform": "linux64-pgo", 09:23:25 INFO - "builduid": "d6c13d86140e4680b93364e2a96ef394", 09:23:25 INFO - "slavebuilddir": "test" 09:23:25 INFO - } 09:23:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:23:25 INFO - Running post-action listener: _resource_record_post_action 09:23:25 INFO - ##### 09:23:25 INFO - ##### Finished read-buildbot-config step (success) 09:23:25 INFO - ##### 09:23:25 INFO - ##### 09:23:25 INFO - ##### Running download-and-extract step. 09:23:25 INFO - ##### 09:23:25 INFO - Running pre-action listener: _resource_record_pre_action 09:23:25 INFO - Running main action method: download_and_extract 09:23:25 INFO - mkdir: /builds/slave/test/build/tests 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:25 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:26 INFO - Downloaded 1361 bytes. 09:23:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:23:26 INFO - Using the following test package requirements: 09:23:26 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:23:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:23:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'jsshell-linux-x86_64.zip'], 09:23:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:23:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:23:26 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:23:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:23:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:26 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:23:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:26 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:23:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:23:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:27 INFO - Downloaded 24220995 bytes. 09:23:27 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'] 09:23:27 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 09:23:28 INFO - Return code: 0 09:23:28 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 09:23:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:28 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:23:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:23:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:23:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:29 INFO - Downloaded 24220995 bytes. 09:23:29 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'] 09:23:29 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 09:23:31 INFO - Return code: 0 09:23:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:31 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:23:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:32 INFO - Downloaded 14405384 bytes. 09:23:32 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'] 09:23:32 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 09:23:32 INFO - Return code: 0 09:23:32 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')]} 09:23:32 INFO - https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:23:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MNb2vAcXT4CR_lx-neIZOw/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 09:23:34 INFO - Downloaded 59389271 bytes. 09:23:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:34 INFO - mkdir: /builds/slave/test/properties 09:23:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:34 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:34 INFO - Contents: 09:23:34 INFO - build_url:https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:34 INFO - Running post-action listener: _resource_record_post_action 09:23:34 INFO - Running post-action listener: set_extra_try_arguments 09:23:34 INFO - ##### 09:23:34 INFO - ##### Finished download-and-extract step (success) 09:23:34 INFO - ##### 09:23:34 INFO - ##### 09:23:34 INFO - ##### Running populate-webroot step. 09:23:34 INFO - ##### 09:23:34 INFO - Running pre-action listener: _resource_record_pre_action 09:23:34 INFO - Running main action method: populate_webroot 09:23:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:34 INFO - '--tppagecycles', 09:23:34 INFO - '7'], 09:23:34 INFO - 'tests': ['tsvgm']}}, 09:23:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['damp', 'tps']}, 09:23:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'tests': ['damp', 'tps']}, 09:23:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['dromaeo_dom']}, 09:23:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['basic_compositor_video']}, 09:23:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:23:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['a11yr', 09:23:34 INFO - 'ts_paint', 09:23:34 INFO - 'tpaint', 09:23:34 INFO - 'sessionrestore', 09:23:34 INFO - 'sessionrestore_no_auto_restore', 09:23:34 INFO - 'tabpaint']}, 09:23:34 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:34 INFO - 'ts_paint', 09:23:34 INFO - 'tpaint', 09:23:34 INFO - 'sessionrestore', 09:23:34 INFO - 'sessionrestore_no_auto_restore', 09:23:34 INFO - 'tabpaint']}, 09:23:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:34 INFO - 'ts_paint', 09:23:34 INFO - 'tpaint', 09:23:34 INFO - 'sessionrestore', 09:23:34 INFO - 'sessionrestore_no_auto_restore', 09:23:34 INFO - 'tabpaint']}, 09:23:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:34 INFO - 'ts_paint', 09:23:34 INFO - 'tpaint', 09:23:34 INFO - 'sessionrestore', 09:23:34 INFO - 'sessionrestore_no_auto_restore', 09:23:34 INFO - 'tabpaint']}, 09:23:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['a11yr', 09:23:34 INFO - 'ts_paint', 09:23:34 INFO - 'tpaint', 09:23:34 INFO - 'sessionrestore', 09:23:34 INFO - 'sessionrestore_no_auto_restore', 09:23:34 INFO - 'tabpaint']}, 09:23:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['a11yr', 09:23:34 INFO - 'ts_paint', 09:23:34 INFO - 'tpaint', 09:23:34 INFO - 'sessionrestore', 09:23:34 INFO - 'sessionrestore_no_auto_restore', 09:23:34 INFO - 'tabpaint']}, 09:23:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['tsvgx', 09:23:34 INFO - 'tsvgr_opacity', 09:23:34 INFO - 'tart', 09:23:34 INFO - 'tscrollx', 09:23:34 INFO - 'cart']}, 09:23:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:34 INFO - 'tsvgr_opacity', 09:23:34 INFO - 'tart', 09:23:34 INFO - 'tscrollx', 09:23:34 INFO - 'cart']}, 09:23:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'talos_options': ['--disable-e10s'], 09:23:34 INFO - 'tests': ['tp5o']}, 09:23:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'tests': ['tp5o']}, 09:23:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'talos_options': ['--disable-e10s', 09:23:34 INFO - '--xperf_path', 09:23:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:34 INFO - 'tests': ['tp5n']}, 09:23:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:34 INFO - 'talos_options': ['--xperf_path', 09:23:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:34 INFO - 'tests': ['tp5n']}}, 09:23:34 INFO - 'talos.zip': {'path': '', 09:23:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:34 INFO - Running post-action listener: _resource_record_post_action 09:23:34 INFO - ##### 09:23:34 INFO - ##### Finished populate-webroot step (success) 09:23:34 INFO - ##### 09:23:34 INFO - ##### 09:23:34 INFO - ##### Running create-virtualenv step. 09:23:34 INFO - ##### 09:23:34 INFO - Running pre-action listener: _resource_record_pre_action 09:23:34 INFO - Running main action method: create_virtualenv 09:23:34 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:34 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 09:23:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:34 INFO - Using real prefix '/usr' 09:23:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:37 INFO - Installing pip.................done. 09:23:37 INFO - Return code: 0 09:23:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:37 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 09:23:37 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 09:23:37 INFO - Using env: {'DISPLAY': ':0', 09:23:37 INFO - 'HOME': '/home/cltbld', 09:23:37 INFO - 'LANG': 'en_US.UTF-8', 09:23:37 INFO - 'LANGUAGE': 'en_US:en', 09:23:37 INFO - 'LOGNAME': 'cltbld', 09:23:37 INFO - 'MAIL': '/var/mail/cltbld', 09:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:37 INFO - 'MOZ_NO_REMOTE': '1', 09:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:37 INFO - 'NO_EM_RESTART': '1', 09:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:37 INFO - 'PWD': '/builds/slave/test', 09:23:37 INFO - 'SHELL': '/bin/bash', 09:23:37 INFO - 'SHLVL': '1', 09:23:37 INFO - 'TERM': 'linux', 09:23:37 INFO - 'TMOUT': '86400', 09:23:37 INFO - 'USER': 'cltbld', 09:23:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:37 INFO - '_': '/tools/buildbot/bin/python'} 09:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:37 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 09:23:37 INFO - Cleaning up... 09:23:37 INFO - Return code: 0 09:23:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:37 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:37 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 09:23:37 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 09:23:37 INFO - Using env: {'DISPLAY': ':0', 09:23:37 INFO - 'HOME': '/home/cltbld', 09:23:37 INFO - 'LANG': 'en_US.UTF-8', 09:23:37 INFO - 'LANGUAGE': 'en_US:en', 09:23:37 INFO - 'LOGNAME': 'cltbld', 09:23:37 INFO - 'MAIL': '/var/mail/cltbld', 09:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:37 INFO - 'MOZ_NO_REMOTE': '1', 09:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:37 INFO - 'NO_EM_RESTART': '1', 09:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:37 INFO - 'PWD': '/builds/slave/test', 09:23:37 INFO - 'SHELL': '/bin/bash', 09:23:37 INFO - 'SHLVL': '1', 09:23:37 INFO - 'TERM': 'linux', 09:23:37 INFO - 'TMOUT': '86400', 09:23:37 INFO - 'USER': 'cltbld', 09:23:37 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:37 INFO - '_': '/tools/buildbot/bin/python'} 09:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:37 INFO - Downloading/unpacking psutil>=3.1.1 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23: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 09:23:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:39 INFO - Installing collected packages: psutil 09:23:39 INFO - Running setup.py install for psutil 09:23:39 INFO - building 'psutil._psutil_linux' extension 09:23:39 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 09:23:40 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 09:23:40 INFO - building 'psutil._psutil_posix' extension 09:23:40 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 09:23:40 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 09:23:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:40 INFO - Successfully installed psutil 09:23:40 INFO - Cleaning up... 09:23:40 INFO - Return code: 0 09:23:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:40 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:40 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 09:23:40 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 09:23:40 INFO - Using env: {'DISPLAY': ':0', 09:23:40 INFO - 'HOME': '/home/cltbld', 09:23:40 INFO - 'LANG': 'en_US.UTF-8', 09:23:40 INFO - 'LANGUAGE': 'en_US:en', 09:23:40 INFO - 'LOGNAME': 'cltbld', 09:23:40 INFO - 'MAIL': '/var/mail/cltbld', 09:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:40 INFO - 'MOZ_NO_REMOTE': '1', 09:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:40 INFO - 'NO_EM_RESTART': '1', 09:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:40 INFO - 'PWD': '/builds/slave/test', 09:23:40 INFO - 'SHELL': '/bin/bash', 09:23:40 INFO - 'SHLVL': '1', 09:23:40 INFO - 'TERM': 'linux', 09:23:40 INFO - 'TMOUT': '86400', 09:23:40 INFO - 'USER': 'cltbld', 09:23:40 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:40 INFO - '_': '/tools/buildbot/bin/python'} 09:23:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:40 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 09:23:40 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 09:23:40 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 09:23:40 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 09:23:40 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 09:23:40 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 09:23:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:42 INFO - Installing collected packages: mozsystemmonitor 09:23:42 INFO - Running setup.py install for mozsystemmonitor 09:23:42 INFO - Successfully installed mozsystemmonitor 09:23:42 INFO - Cleaning up... 09:23:42 INFO - Return code: 0 09:23:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:23:42 INFO - Using env: {'DISPLAY': ':0', 09:23:42 INFO - 'HOME': '/home/cltbld', 09:23:42 INFO - 'LANG': 'en_US.UTF-8', 09:23:42 INFO - 'LANGUAGE': 'en_US:en', 09:23:42 INFO - 'LOGNAME': 'cltbld', 09:23:42 INFO - 'MAIL': '/var/mail/cltbld', 09:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:42 INFO - 'MOZ_NO_REMOTE': '1', 09:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:42 INFO - 'NO_EM_RESTART': '1', 09:23:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:42 INFO - 'PWD': '/builds/slave/test', 09:23:42 INFO - 'SHELL': '/bin/bash', 09:23:42 INFO - 'SHLVL': '1', 09:23:42 INFO - 'TERM': 'linux', 09:23:42 INFO - 'TMOUT': '86400', 09:23:42 INFO - 'USER': 'cltbld', 09:23:42 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:42 INFO - '_': '/tools/buildbot/bin/python'} 09:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:42 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:45 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:45 INFO - warning: no files found matching '*.txt' 09:23:45 INFO - no previously-included directories found matching 'build' 09:23:45 INFO - no previously-included directories found matching 'dist' 09:23:45 INFO - no previously-included directories found matching '.git*' 09:23:45 INFO - Installing collected packages: jsonschema, functools32 09:23:45 INFO - Running setup.py install for functools32 09:23:45 INFO - warning: no files found matching '*.txt' 09:23:45 INFO - no previously-included directories found matching 'build' 09:23:45 INFO - no previously-included directories found matching 'dist' 09:23:45 INFO - no previously-included directories found matching '.git*' 09:23:45 INFO - Successfully installed jsonschema functools32 09:23:45 INFO - Cleaning up... 09:23:45 INFO - Return code: 0 09:23:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:45 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:45 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 09:23:45 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 09:23:45 INFO - Using env: {'DISPLAY': ':0', 09:23:45 INFO - 'HOME': '/home/cltbld', 09:23:45 INFO - 'LANG': 'en_US.UTF-8', 09:23:45 INFO - 'LANGUAGE': 'en_US:en', 09:23:45 INFO - 'LOGNAME': 'cltbld', 09:23:45 INFO - 'MAIL': '/var/mail/cltbld', 09:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:45 INFO - 'MOZ_NO_REMOTE': '1', 09:23:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:45 INFO - 'NO_EM_RESTART': '1', 09:23:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:45 INFO - 'PWD': '/builds/slave/test', 09:23:45 INFO - 'SHELL': '/bin/bash', 09:23:45 INFO - 'SHLVL': '1', 09:23:45 INFO - 'TERM': 'linux', 09:23:45 INFO - 'TMOUT': '86400', 09:23:45 INFO - 'USER': 'cltbld', 09:23:45 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:45 INFO - '_': '/tools/buildbot/bin/python'} 09:23:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 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 09:23:47 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 09:23:48 INFO - Downloading docopt-0.6.1.tar.gz 09:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:48 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:48 INFO - Running setup.py install for blobuploader 09:23:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:48 INFO - Running setup.py install for requests 09:23:48 INFO - Running setup.py install for docopt 09:23:48 INFO - Successfully installed blobuploader requests docopt 09:23:48 INFO - Cleaning up... 09:23:48 INFO - Return code: 0 09:23:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:48 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:48 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 09:23:48 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 09:23:48 INFO - Using env: {'DISPLAY': ':0', 09:23:48 INFO - 'HOME': '/home/cltbld', 09:23:48 INFO - 'LANG': 'en_US.UTF-8', 09:23:48 INFO - 'LANGUAGE': 'en_US:en', 09:23:48 INFO - 'LOGNAME': 'cltbld', 09:23:48 INFO - 'MAIL': '/var/mail/cltbld', 09:23:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:48 INFO - 'MOZ_NO_REMOTE': '1', 09:23:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:48 INFO - 'NO_EM_RESTART': '1', 09:23:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:48 INFO - 'PWD': '/builds/slave/test', 09:23:48 INFO - 'SHELL': '/bin/bash', 09:23:48 INFO - 'SHLVL': '1', 09:23:48 INFO - 'TERM': 'linux', 09:23:48 INFO - 'TMOUT': '86400', 09:23:48 INFO - 'USER': 'cltbld', 09:23:48 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:48 INFO - '_': '/tools/buildbot/bin/python'} 09:23:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:48 INFO - Running setup.py (path:/tmp/pip-U_mBkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:49 INFO - Running setup.py (path:/tmp/pip-dn1pQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:49 INFO - Running setup.py (path:/tmp/pip-Si1XOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:49 INFO - Running setup.py (path:/tmp/pip-BK2JEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:49 INFO - Running setup.py (path:/tmp/pip-Y97tMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:49 INFO - Running setup.py (path:/tmp/pip-0CFPWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:49 INFO - Running setup.py (path:/tmp/pip-NSU0BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:49 INFO - Running setup.py (path:/tmp/pip-DOqQaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:49 INFO - Running setup.py (path:/tmp/pip-K_cb41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:49 INFO - Running setup.py (path:/tmp/pip-YFsMnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:49 INFO - Running setup.py (path:/tmp/pip-DLsRJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:49 INFO - Running setup.py (path:/tmp/pip-P6KhjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:49 INFO - Running setup.py (path:/tmp/pip-UPgwP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:49 INFO - Running setup.py (path:/tmp/pip-IHPkOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:49 INFO - Running setup.py (path:/tmp/pip-foHpdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:50 INFO - Running setup.py (path:/tmp/pip-eVolgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:50 INFO - Running setup.py (path:/tmp/pip-VlS7xV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:50 INFO - Running setup.py install for manifestparser 09:23:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Running setup.py install for mozcrash 09:23:50 INFO - Running setup.py install for mozdebug 09:23:50 INFO - Running setup.py install for mozdevice 09:23:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Running setup.py install for mozfile 09:23:50 INFO - Running setup.py install for mozhttpd 09:23:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Running setup.py install for mozinfo 09:23:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Running setup.py install for mozInstall 09:23:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for mozleak 09:23:51 INFO - Running setup.py install for mozlog 09:23:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for moznetwork 09:23:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for mozprocess 09:23:51 INFO - Running setup.py install for mozprofile 09:23:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for mozrunner 09:23:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Running setup.py install for mozscreenshot 09:23:51 INFO - Running setup.py install for moztest 09:23:51 INFO - Running setup.py install for mozversion 09:23:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:51 INFO - Cleaning up... 09:23:52 INFO - Return code: 0 09:23:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:52 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')]} 09:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 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')]} 09:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:52 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:52 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 09:23:52 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 09:23:52 INFO - Using env: {'DISPLAY': ':0', 09:23:52 INFO - 'HOME': '/home/cltbld', 09:23:52 INFO - 'LANG': 'en_US.UTF-8', 09:23:52 INFO - 'LANGUAGE': 'en_US:en', 09:23:52 INFO - 'LOGNAME': 'cltbld', 09:23:52 INFO - 'MAIL': '/var/mail/cltbld', 09:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:52 INFO - 'MOZ_NO_REMOTE': '1', 09:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:52 INFO - 'NO_EM_RESTART': '1', 09:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:52 INFO - 'PWD': '/builds/slave/test', 09:23:52 INFO - 'SHELL': '/bin/bash', 09:23:52 INFO - 'SHLVL': '1', 09:23:52 INFO - 'TERM': 'linux', 09:23:52 INFO - 'TMOUT': '86400', 09:23:52 INFO - 'USER': 'cltbld', 09:23:52 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:52 INFO - '_': '/tools/buildbot/bin/python'} 09:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:52 INFO - Running setup.py (path:/tmp/pip-k7VUJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:52 INFO - Running setup.py (path:/tmp/pip-v91f3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:52 INFO - Running setup.py (path:/tmp/pip-680qm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:52 INFO - Running setup.py (path:/tmp/pip-Ldh_Jd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:52 INFO - Running setup.py (path:/tmp/pip-qJt5YR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:52 INFO - Running setup.py (path:/tmp/pip-Xy1fF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:52 INFO - Running setup.py (path:/tmp/pip-Y0jLx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:52 INFO - Running setup.py (path:/tmp/pip-S0suFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:52 INFO - Running setup.py (path:/tmp/pip-aH1oGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:52 INFO - Running setup.py (path:/tmp/pip-iIzGZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:52 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)) 09:23:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:52 INFO - Running setup.py (path:/tmp/pip-qdmnOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:53 INFO - Running setup.py (path:/tmp/pip-_QUExG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:53 INFO - Running setup.py (path:/tmp/pip-i_qA4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:53 INFO - Running setup.py (path:/tmp/pip-YZ2d1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:53 INFO - Running setup.py (path:/tmp/pip-z9psPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:53 INFO - Running setup.py (path:/tmp/pip-Gl0xYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:53 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)) 09:23:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:53 INFO - Running setup.py (path:/tmp/pip-IPtStu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:53 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)) 09:23:53 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)) 09:23:53 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)) 09:23:53 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)) 09:23:53 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)) 09:23:53 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)) 09:23:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:53 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 09:23:53 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 09:23:53 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 09:23:53 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 09:23:53 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 09:23:53 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 09:23:55 INFO - Downloading blessings-1.6.tar.gz 09:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:55 INFO - Installing collected packages: blessings 09:23:55 INFO - Running setup.py install for blessings 09:23:55 INFO - Successfully installed blessings 09:23:55 INFO - Cleaning up... 09:23:55 INFO - Return code: 0 09:23:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:55 INFO - Reading from file tmpfile_stdout 09:23:55 INFO - Current package versions: 09:23:55 INFO - argparse == 1.2.1 09:23:55 INFO - blessings == 1.6 09:23:55 INFO - blobuploader == 1.2.4 09:23:55 INFO - docopt == 0.6.1 09:23:55 INFO - functools32 == 3.2.3-2 09:23:55 INFO - jsonschema == 2.5.1 09:23:55 INFO - manifestparser == 1.1 09:23:55 INFO - mozInstall == 1.12 09:23:55 INFO - mozcrash == 0.17 09:23:55 INFO - mozdebug == 0.1 09:23:55 INFO - mozdevice == 0.48 09:23:55 INFO - mozfile == 1.2 09:23:55 INFO - mozhttpd == 0.7 09:23:55 INFO - mozinfo == 0.9 09:23:55 INFO - mozleak == 0.1 09:23:55 INFO - mozlog == 3.2 09:23:55 INFO - moznetwork == 0.27 09:23:55 INFO - mozprocess == 0.22 09:23:55 INFO - mozprofile == 0.28 09:23:55 INFO - mozrunner == 6.11 09:23:55 INFO - mozscreenshot == 0.1 09:23:55 INFO - mozsystemmonitor == 0.3 09:23:55 INFO - moztest == 0.7 09:23:55 INFO - mozversion == 1.4 09:23:55 INFO - psutil == 3.1.1 09:23:55 INFO - requests == 1.2.3 09:23:55 INFO - wsgiref == 0.1.2 09:23:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:55 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:55 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 09:23:55 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 09:23:55 INFO - Using env: {'DISPLAY': ':0', 09:23:55 INFO - 'HOME': '/home/cltbld', 09:23:55 INFO - 'LANG': 'en_US.UTF-8', 09:23:55 INFO - 'LANGUAGE': 'en_US:en', 09:23:55 INFO - 'LOGNAME': 'cltbld', 09:23:55 INFO - 'MAIL': '/var/mail/cltbld', 09:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:55 INFO - 'MOZ_NO_REMOTE': '1', 09:23:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:55 INFO - 'NO_EM_RESTART': '1', 09:23:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:55 INFO - 'PWD': '/builds/slave/test', 09:23:55 INFO - 'SHELL': '/bin/bash', 09:23:55 INFO - 'SHLVL': '1', 09:23:55 INFO - 'TERM': 'linux', 09:23:55 INFO - 'TMOUT': '86400', 09:23:55 INFO - 'USER': 'cltbld', 09:23:55 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:55 INFO - '_': '/tools/buildbot/bin/python'} 09:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:55 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 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)) 09:23:56 INFO - Cleaning up... 09:23:56 INFO - Return code: 0 09:23:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:56 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:56 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 09:23:56 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 09:23:56 INFO - Using env: {'DISPLAY': ':0', 09:23:56 INFO - 'HOME': '/home/cltbld', 09:23:56 INFO - 'LANG': 'en_US.UTF-8', 09:23:56 INFO - 'LANGUAGE': 'en_US:en', 09:23:56 INFO - 'LOGNAME': 'cltbld', 09:23:56 INFO - 'MAIL': '/var/mail/cltbld', 09:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:56 INFO - 'MOZ_NO_REMOTE': '1', 09:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:56 INFO - 'NO_EM_RESTART': '1', 09:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:56 INFO - 'PWD': '/builds/slave/test', 09:23:56 INFO - 'SHELL': '/bin/bash', 09:23:56 INFO - 'SHLVL': '1', 09:23:56 INFO - 'TERM': 'linux', 09:23:56 INFO - 'TMOUT': '86400', 09:23:56 INFO - 'USER': 'cltbld', 09:23:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:56 INFO - '_': '/tools/buildbot/bin/python'} 09:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:56 INFO - Cleaning up... 09:23:56 INFO - Return code: 0 09:23:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:56 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 0x7f8fe650bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ae7350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, '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': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', '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 09:23:56 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 09:23:56 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 09:23:56 INFO - Using env: {'DISPLAY': ':0', 09:23:56 INFO - 'HOME': '/home/cltbld', 09:23:56 INFO - 'LANG': 'en_US.UTF-8', 09:23:56 INFO - 'LANGUAGE': 'en_US:en', 09:23:56 INFO - 'LOGNAME': 'cltbld', 09:23:56 INFO - 'MAIL': '/var/mail/cltbld', 09:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:56 INFO - 'MOZ_NO_REMOTE': '1', 09:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:56 INFO - 'NO_EM_RESTART': '1', 09:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:56 INFO - 'PWD': '/builds/slave/test', 09:23:56 INFO - 'SHELL': '/bin/bash', 09:23:56 INFO - 'SHLVL': '1', 09:23:56 INFO - 'TERM': 'linux', 09:23:56 INFO - 'TMOUT': '86400', 09:23:56 INFO - 'USER': 'cltbld', 09:23:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:56 INFO - '_': '/tools/buildbot/bin/python'} 09:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:56 INFO - Downloading/unpacking flake8 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:23:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:23:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:23:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:59 INFO - no previously-included directories found matching 'docs/_build' 09:23:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:23:59 INFO - Running setup.py install for pep8 09:23:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:23:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:23:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:23:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:23:59 INFO - no previously-included directories found matching 'docs/_build' 09:23:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:23:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:23:59 INFO - Cleaning up... 09:23:59 INFO - Return code: 0 09:23:59 INFO - Running post-action listener: _resource_record_post_action 09:23:59 INFO - Running post-action listener: _start_resource_monitoring 09:23:59 INFO - Starting resource monitoring. 09:23:59 INFO - ##### 09:23:59 INFO - ##### Finished create-virtualenv step (success) 09:23:59 INFO - ##### 09:23:59 INFO - ##### 09:23:59 INFO - ##### Running install step. 09:23:59 INFO - ##### 09:23:59 INFO - Running pre-action listener: _resource_record_pre_action 09:23:59 INFO - Running main action method: install 09:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:59 INFO - Reading from file tmpfile_stdout 09:23:59 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:59 INFO - Reading from file tmpfile_stdout 09:23:59 INFO - Output received: 09:23:59 INFO - Usage: mozinstall [options] installer 09:23:59 INFO - Options: 09:23:59 INFO - -h, --help show this help message and exit 09:23:59 INFO - -d DEST, --destination=DEST 09:23:59 INFO - Directory to install application into. [default: 09:23:59 INFO - "/builds/slave/test"] 09:23:59 INFO - --app=APP Application being installed. [default: firefox] 09:23:59 INFO - mkdir: /builds/slave/test/build/application 09:23:59 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'] 09:23:59 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 09:24:16 INFO - Reading from file tmpfile_stdout 09:24:16 INFO - Output received: 09:24:16 INFO - /builds/slave/test/build/application/firefox/firefox 09:24:16 INFO - Running post-action listener: _resource_record_post_action 09:24:16 INFO - ##### 09:24:16 INFO - ##### Finished install step (success) 09:24:16 INFO - ##### 09:24:16 INFO - ##### 09:24:16 INFO - ##### Running run-tests step. 09:24:16 INFO - ##### 09:24:16 INFO - Running pre-action listener: _resource_record_pre_action 09:24:16 INFO - Running main action method: run_tests 09:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:16 INFO - Python 2.7.3 09:24:16 INFO - Return code: 0 09:24:16 INFO - grabbing minidump binary from tooltool 09:24: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')]} 09:24:16 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 0x1b761c0>, '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 0x1b770c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b77550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:16 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 09:24:16 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 09:24:16 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 09:24:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:16 INFO - Return code: 0 09:24:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:24:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:24:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:24:17 INFO - Return code: 0 09:24:17 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/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 09:24:17 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/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 09:24:17 INFO - Using env: {'DISPLAY': ':0', 09:24:17 INFO - 'HOME': '/home/cltbld', 09:24:17 INFO - 'LANG': 'en_US.UTF-8', 09:24:17 INFO - 'LANGUAGE': 'en_US:en', 09:24:17 INFO - 'LOGNAME': 'cltbld', 09:24:17 INFO - 'MAIL': '/var/mail/cltbld', 09:24:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:17 INFO - 'MOZ_NO_REMOTE': '1', 09:24:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:17 INFO - 'NO_EM_RESTART': '1', 09:24:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:17 INFO - 'PWD': '/builds/slave/test', 09:24:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:17 INFO - 'SHELL': '/bin/bash', 09:24:17 INFO - 'SHLVL': '1', 09:24:17 INFO - 'TERM': 'linux', 09:24:17 INFO - 'TMOUT': '86400', 09:24:17 INFO - 'USER': 'cltbld', 09:24:17 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699', 09:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:17 INFO - '_': '/tools/buildbot/bin/python'} 09:24:17 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/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 09:24:17 INFO - mozversion application_buildid: 20160617062337 09:24:17 INFO - mozversion application_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 09:24:17 INFO - mozversion application_display_name: Nightly 09:24:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:17 INFO - mozversion application_name: Firefox 09:24:17 INFO - mozversion application_remotingname: firefox 09:24:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:24:17 INFO - mozversion application_vendor: Mozilla 09:24:17 INFO - mozversion application_version: 50.0a1 09:24:17 INFO - mozversion platform_buildid: 20160617062337 09:24:17 INFO - mozversion platform_changeset: 535a13bd2bf94fcc72d7e2432100fba85f7c322a 09:24:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:24:17 INFO - mozversion platform_version: 50.0a1 09:24:17 INFO - using testdate: 1466180657 09:24:17 INFO - actual date: 1466180657 09:24:17 INFO - starting webserver on 'localhost:42772' 09:24:17 INFO - SUITE-START | Running 2 tests 09:24:17 INFO - TEST-START | dromaeo_css 09:24:17 INFO - operating with platform_type : linux_ 09:24:17 INFO - Initialising browser for dromaeo_css test... 09:24:17 INFO - TEST-INFO | started process 18148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz9xX85/profile http://localhost:42772/getInfo.html) 09:24:22 INFO - PROCESS | 18148 | __metrics Screen width/height:1600/1200 09:24:22 INFO - PROCESS | 18148 | colorDepth:24 09:24:22 INFO - PROCESS | 18148 | Browser inner width/height: 1024/697 09:24:22 INFO - PROCESS | 18148 | __metrics 09:24:23 ERROR - PROCESS | 18148 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:24:24 INFO - TEST-INFO | 18148: exit 0 09:24:24 INFO - Browser initialized. 09:24:24 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:24 INFO - TEST-INFO | started process 18267 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz9xX85/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:36 INFO - PROCESS | 18267 | RSS: Main: 184717312 09:24:36 INFO - PROCESS | 18267 | 09:25:25 INFO - PROCESS | 18267 | 1466180725677 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] 09:27:33 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:42772/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42772/tests/dromaeo/cssquery-ext.html) 09:27:35 INFO - PROCESS | 18267 | RSS: Main: 189083648 09:27:35 INFO - PROCESS | 18267 | 09:30:37 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:42772/tests/dromaeo/cssquery-ext.html (next: http://localhost:42772/tests/dromaeo/cssquery-jquery.html) 09:30:37 INFO - PROCESS | 18267 | RSS: Main: 187633664 09:30:37 INFO - PROCESS | 18267 | 09:33:39 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:42772/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42772/tests/dromaeo/cssquery-mootools.html) 09:33:40 INFO - PROCESS | 18267 | RSS: Main: 188796928 09:33:40 INFO - PROCESS | 18267 | 09:36:42 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:42772/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42772/tests/dromaeo/cssquery-prototype.html) 09:36:42 INFO - PROCESS | 18267 | RSS: Main: 186302464 09:36:42 INFO - PROCESS | 18267 | 09:39:45 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:42772/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42772/tests/dromaeo/cssquery-yui.html) 09:39:45 INFO - PROCESS | 18267 | RSS: Main: 188121088 09:39:45 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | Cycle 1(1): loaded http://localhost:42772/tests/dromaeo/cssquery-yui.html (next: http://localhost:42772/tests/dromaeo/cssquery-dojo.html) 09:42:48 INFO - PROCESS | 18267 | RSS: Main: 189210624 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | __start_tp_report 09:42:48 INFO - PROCESS | 18267 | _x_x_mozilla_page_load 09:42:48 INFO - PROCESS | 18267 | _x_x_mozilla_page_load_details 09:42:48 INFO - PROCESS | 18267 | |i|pagename|runs| 09:42:48 INFO - PROCESS | 18267 | |0;dojo.html;3093.103000129962;3118.3451475190195;3132.6867313268667;3153.132888455674;3154.558361829346;5309.548688361489;5311.73441327934;5312.521873031426;5446.428125046872;5469.234307196995;5310.20346947958;5397.379301380342;5445.754941027653;5472.50747432731;5484.8354549363485;4922.114019476493;4944.060628480577;4984.102861484949;5106.285120083191;5154.201098829687;4921.360223171001;5081.161608334621;5099.286099946011;5103.132467480518;5111.284420181178;4854.951450485521;4920.089783390084;4922.212446008622;4964.255361695757;4981.203007518798;4931.211006238985;4942.555170034714;4946.233333833262;4947.480514545993;5018.723970181639;4928.063667903087;4930.802767889316;4948.455669876311;4971.701697898102;4979.4771548987555;5187.766550505236;5377.677339359651;5385.272988146589;5418;5473.534749546254;5796.50729687977;5842.503387212092;5843.824685259449;5864.1203819427;5865.208196893407;5672.432756724335;5864.237649105632;5872.647641141502;5879.059350503899;5882.205902203191;5418.810341638024;5445.047116754552;5470.370907345667;5489.615726899158;5498.092814685572;6004.309504406961;6008.969955150196;6012.879742405127;6015.909761353583;6025.8192254232445;5563.972180139073;5597.608167428241;5791.913121303184;5804.593678442468;5817.272840894888;5728.198052272685;5799.246098007232;5799.5650326225705;5801.448862358069;5856.326522449887;5579.916301255404;5727.083666613322;5757.8560535986935;5773.653580785166;5787.5080618147085;5609.915851262234;5715.514181294553;5795.971020144872;5821.155932389865;5834.620749651259;4354.455693038371;4458.665600080007;4462.219111655448;4503.144402563503;4506.324051392252;3959.307121253769;3976.2445135424177;3987.9631295863283;3999.7800120993625;4014.437978682987;5412.5940554458575;5516.393196748354;5520.66875987442;5523.475269849358;5571.498565129158;5840.153177789197;5871.706414679249;5900.4099590041515;5910.202122713465;5962.672053037125;5549.916751248735;5577.191307260425;5577.414371491016;5596.3284405871555;5609.523190528851;4870.951290487121;4948.035133149001;4948.678335908155;4994.051130285234;5031.698098114125;6035.818925432244;6045.486133678686;6047.455728984324;6058.969705151446;6068.423499767515;5786.103154011051;5821.679807610622;5823.097419899922;5825.679587622722;5850.180974663635;5812.534997200299;5942.10868369748;5942.554308426972;6000.639961602318;6035.969820150871;5658.264425624642;5696.857578560569;5697.515711164431;5698.857528561819;5725.484706376446;5614.157876318585;5745.885082298247;5826.592138550261;5827.155062515996;5832.3292821326095;5526.447355264441;5596.720163991866;5656.123300888369;5688.601797874109;5758.654480731169;5537.529310008695;5548.805791797267;5590.8043218487155;5635.633683810704;5639.605227634191;5503.2020357048805;5510.641808282448;5550.861228469321;5551.417101204477;5559;5539.972300138474;5616.69108199053;5660.264165658438;5736.770529178786;5761.222234998221;5564.443555644403;5589.636673616202;5612.971935140298;5615.3823079462045;5629.043062679272 09:42:48 INFO - PROCESS | 18267 | |1;ext.html;594.8453402115451;630.1241274628267;640.823773462298;651.8142329436112;662.7315937045498;32796.18009549763;36499.27001459969;36509.26981460369;36528.81735591322;36619.633803661956;41913.79043104788;42016.369754453706;42452.57547424533;42503.36244956328;42624.78687606558;8746.956265218681;8747;8824.294056475499;8833.823323533525;8905.73282801517;8690.956545217297;8706;8785.472871627691;8787.25308348791;8807.867881981776;8807.559622018905;8809.471431714117;8818.426802257865;8848.690295839648;8855.512946787923;8746.606402711894;8747.868781968276;8772.12278772124;8815.294776417903;8826.205641492264;8710.912890871074;8755.77419161318;8760.123987601253;8788.912110878873;8791.560421978875;40035;40221.79889100565;40347.19305613871;40445.191096177914;40528.59471405278;2993;3205.6954589313978;3456.2914602506426;3543.553073955439;3625.546806649169;32233.6776632233;32362.83818580892;32632.347353053043;33718.662813372044;34024;4298.475517615527;4355.499117601453;4356.934645980313;4373.169097871394;4398.34024896265;323729;324016;325883;326182;326599;57750.4224957745;57902.13146802801;58061.4193858056;58129;58193;34890.30219395598;35671.64328356683;35879;37334.813325933195;37731.62268377336;14203.431862725582;14289.785653215211;14322.498712545012;14333.14001159913;14349.139051656934;12052.035837133008;12056.578019769266;12088.697782555331;12096.81854772179;12117.21238119537;19060;19278.885931596873;19311.710324345146;19323.710144347846;19515.51211219731;7026.613536255452;7283.672234749449;7291.270872912666;7394.704211831574;7531.472796904164;951.2817822543935;976.7069879036403;1018.6180182431589;1026.235454586338;1125.7692173104494;32242.677573224435;33914.15214619605;36174;36533;36619;1094.370736826328;1151.2862025544216;1176.4118440105788;1182.5920057580122;1184.0350114656528;16933;17233.827661723473;17526.474205773848;17529.56176095608;17702.91148544249;527945;539870;540334;864351;875635;56147;57193.42806571964;57302.7134864323;57323.713381432826;57424.13863792046;1336.211635135275;1356.6608347912825;1357.0365040821127;1373.6565858535366;1386.105961654727;31808.36383272368;33348.66651333456;33404.498932516515;33901.83049084739;33960.320793583494;51532;51692.74153629208;51996.74001629968;52580.21129682981;52584.737076315905;460805;467257;471913;472719;473784;27867.581986270627;27977.580336295377;28320.858395707888;28402.85798570994;28433.857830710713;46790.298145528526;46792.7660361696;47394;47861.76069119771;47967;38967.805160974014;40671.796641016605;40777;40983;41148.79425602853;38942.6105738939;39843.40234896537;40674.59325406826;40905.18189636131;40912;40968.38547421851;43979.560204397545;44127;45156;45218.32172517481;39391.80304098461;40846.59153408428;41670.79164604157;43517.56482435135;43917;34479;34849.65150348464;35002.64997349994;35154;35183.472247915786 09:42:48 INFO - PROCESS | 18267 | |2;jquery.html;384.5692824037078;392.49956305710236;394.26863168821836;394.57780175212514;412.30320757919117;13740.793888091686;17730.556736081606;18076.909615451903;19470.123844427017;19502.219911203552;18419.26322947084;18474.16866241019;19033;19382.418527444162;19581.118849651764;5500.669959802414;5541.9168712469145;5668.971655141719;5972.73122709477;5990.8502287442725;5393.73031348433;5737;5831.096180092071;5857.6485410875275;5914;5747.33905600855;5778.075507918734;5792.073268277077;5810.477057064863;5815.62198457101;5495.203195536645;5784.884302313952;5825.242718446596;5892.027815410452;5921.585489015771;5469.234307196995;5627.493525582717;5644.8306550803545;5662.2639056922335;5704.172894930211;21971.34085977423;22155.113795448164;22852.65721014186;22858.657120143213;23181;2336.0655737704883;2361.0437772702085;2419.52819200256;2444.841085329466;2535.7210706822234;13866.4453421863;14490.927545362205;15325.923370383076;15655.608609784733;16183.43357982465;1934.6517626827165;1939.078937504674;1950.5806251655963;2029.046348216336;2124.7556530998977;93563.62002695538;95569;96067.51966240125;96392;97403;16671;17632.823671763374;17881.7317740234;18067.72898406525;18115.72826407605;31763.364732705217;31800.363992720017;31923.92494487851;32067.51898721521;32196;9455.29085318604;9675;9776.413415195111;9798.706038818847;9824.459654718916;7584.696612135564;7631;8085.7017149240755;8110.63502142405;8233.17668233172;8971.551422428984;8997.795540092719;9011.909880901107;9075.364724469357;9271.721848344425;3542.9645703542633;3546.308469848355;3549.4512624208296;3579.1767893384667;3608.1701208722143;857.4340934982881;1004.5529739265957;1016.3343010328247;1035.9741006474749;1052.7631282961427;19088.61822763565;19372.903135484234;19454.70817937732;19578.902105489666;19612;935.0742764663071;959.4291396619001;1003.533356988989;1005.9547320370601;1076.0853274716585;10314;11031.2278140531;11077.556897724;11086.891310868848;11121;439905;446225;450905;452829;454185;92220;97733.51133244288;99229;99849;100601;936.836053690615;941.7457286532734;948.3029972969862;951.2057432044182;959.9664011759555;16954.660906782043;16980.915095424443;17043.40348087811;17077.57306067358;17236.224369903633;40566.79716601516;40651;40818.387724183565;41521.584784151775;41584.37623435591;58135.70932145312;58961;59740.701296494975;59820.40179598148;59919.700401497714;7940.642671079931;8074;8181.959090204511;8329.958350208453;8398.286145677686;12692.936535317263;12765.93617031909;13011.284379359226;13049.217046977212;13101.475940962255;11183.776324473627;11490.195686301879;11561;11739.23694959825;11741.29552226869;10428.791424171626;10972.615958441416;11514.30914145154;11522.539098436304;11569.479373428385;11299.322040677585;11332.773344532898;11546.307221566733;11739.119566032752;11871.881281187078;7717.884231736416;8075.959620201861;8206.425550211428;8213.507189568645;8335.833283334421;5814.651120932757;11121.27711698737;11299.039581635325;11674;11711.590094346657 09:42:48 INFO - PROCESS | 18267 | |3;mootools.html;1414.9221792801397;1426.0089237979605;1503.1582313904207;1650.8349165083487;1653.7023335799565;7643.770686879388;7927.563983980879;8246.381521385898;8863.601137948799;8873.201411872938;8264.33885289177;8273.544955027472;8295.046069701986;8329.37529685273;8409.159084091587;2071.2957594417894;2117.068489864462;2117.819985301251;2117.957640847182;2119.2688522459725;2025.8885761283123;2034.1354924157247;2043.5095577061472;2063.030375723408;2070.0684691888637;2033.9084741186682;2048.9077991490417;2056.4858785303672;2060.763012253595;2063.174730107954;2020.5554777948976;2047.0788145334511;2051.148773259103;2054.5171884607107;2055.578606385695;1993.401979406187;2006.2276023730822;2015.093208056366;2045.110376986001;2048.7643920948985;8374.539400332978;8413.158684131538;8425.452345597578;8426.07313195548;8464.111268316861;4862.270659401082;4999.175136102575;5003.799848006075;5013.874653133665;5017.397912250517;3225.6935591118804;3257.4950882613234;3311.172206948263;3374.5275661407422;3377.493375993596;1080.254624309224;1099.0987390339924;1115.7712668902855;1126.4649291586513;1130.5477808876433;11972.281663100155;12078.396080195955;12119.454624541917;12130.939345303304;12140.271583705005;4338.154059958341;4346.478422589246;4419.712718673276;4422.646188304928;4513.864584062483;9541.141297283279;9575.664851730156;9614.18279446255;9627.518624068769;9644.469554174448;4805.567498925114;4823.95176048235;4839.564439200419;4839.782209800567;4842.225243960949;4062.837486500566;4465.151621191963;4516.954830451719;4522.5025247222775;4588.036512332381;3537.46937959303;3539.309834582232;3545.94681079784;3599.8200089995394;3633.0554055945645;1076.9138468922467;1081.34578579958;1088.1838621034224;1092.1044743310408;1097.8956999085074;904.0372003815914;958.242988039455;995.1143482300758;997.5754751126666;1010.777628921636;6111.572189946661;6126.540509461808;6180.81457556274;6182.845428864314;6190.226221722285;411.2699957575268;420.7265277569604;421.11355596469605;1013.3869009249445;1043.7703705184847;4128.91742165155;4150.294449943517;4173.916521669549;4204.453421055243;4236.131593023423;10377.429241391645;10386.740331491623;10454.895451045544;10502.107320877658;10548;10339.844902326471;10375.27373083892;10382.584696612052;10385.273030887765;10392.480375981171;7596.506227095221;7699.576523291161;7709.9614501927135;7795.727149549739;7824.061112666403;5976.193213916065;6216.378362163929;6225.190725205694;6278.686065696788;6365.96817015912;9751.122398984126;9943.950280248553;9955.352902061342;10034.64878729241;10060.49697515136;9780.951095244764;10032;10063.496825158567;10143.188544916242;10234.948825256124;6697.899531507129;7282.599457029914;7408.148062972611;7426.18311985692;7687.654055567625;8393.32853371741;8485.660573576988;8512.191341822518;8565.05784363707;8571.57142142903;7163.4269258460245;7237.276272372721;7361.4110871129105;7500.512466689648;7553.622318883924;7412.592307423143;7505.812354691177;7604.049493813273;7632.236776322324;7759.418043646636;6460;6478.967605161944;6501.674916254263;6507.316731743288;6546.345365463416;4854.975725121351;4970.925436118533;4986.551210391082;5073.594112471067;5111.309973153577;4948.05986862495;5012.423571289349;5066.59467242627;5203.375594928632;5310.920336195038 09:42:48 INFO - PROCESS | 18267 | |4;prototype.html;304.63900278170354;316.4083164482418;320.2330418647338;320.34969012903804;321.6237002706833;5497.5601951843855;5523.475269849358;5639.915401268984;5731.51282141018;5734;5502.30387110316;5556.416576259495;5586.804461843836;5613.494785469307;5618.719064046792;4282.464691913511;4296.935545966813;4297.914041719179;4301.19349873054;4330.7401555906745;4115.218108559364;4325.632321252698;4333.4799824021;4344.695871289011;4360.694751367406;4281.036766727492;4297.333913243437;4305.182015417061;4308.9353659695125;4321.9783901080455;4312.547182545819;4324.437823083011;4333.176696427684;4338.112920879427;4352.695311328208;3639.6906262967677;3730.794806285653;3778.848846046155;3779.261539691745;3792.393217085281;5340;5431.049566325877;5449.836504904859;5481.342238931354;5483.2049352844015;4779.880502987418;4852.757362131879;4859.2954021666665;4942;4948;5575.386707462176;5771.278590176228;5795.478406943354;5853.88292234153;5890.440408161217;4111.177764447122;4113.321301985169;4120.011197312653;4132.173565286955;4132.2561938850995;6129.7854575090105;6173.2900716417735;6180.505559555225;6198.81403557894;6223.786361659479;4108.130800485832;4167.208230436268;4206.600372964564;4208.705390622688;4233.428487154195;4263.8081286342185;4281.314989601711;4281.486221653359;4285.442892423965;4294.957050429518;4891.241857512091;4910.779014944336;4923.926141107886;4939.259111133287;4940.456549779521;5736.6558006519745;5878.206442130343;5922.230110085661;5950.672713000827;5960.701964901824;1455.5415044261024;1463.9093875062933;1467.4570408948757;1468.0971202710257;1474.6018574984694;867.8568036273944;906.1572737354323;908.9636414543344;920.5535315372039;924.9722508324761;4987.975060124676;5024.598032157419;5045;5045.899082018339;5124.359455068116;5322.733863306897;5378.354597448331;5400.567954563626;5437.510624043855;5443.863903402367;4869.659123861366;4927.457979622239;5035.015334818503;5053.534475002281;5076.8476945690945;2843.6018957345987;2896.898608548691;2904.8547572621283;2910.4906641338102;2938.779591530601;5523.28197334344;5591.804286849941;5611.354694210137;5620.662760234317;5729.88540229193;5504.981578408007;5676.716164191774;6182.907256391158;6193.287771906198;6200.472959798378;6339.809805705836;6351.142595749607;6353.777617783263;6395.424411802867;6398.61608303494;5949.494292984971;6068.997230913699;6089.969550152221;6106.3283038866575;6125.540584456273;5948.702564871825;6037.335893051849;6046.879062418639;6048.243969503812;6071.241094863142;5775.249217601685;6348.682565871595;6355.586886852339;6398.296187419473;6404.455621272244;4052.4326594276235;4111.362738775495;4120.454829438961;4129.545749967561;4134.1731653668785;6071.514278857592;6097.939020609914;6113.57204995646;6152.107944347955;6198.349173336915;5840.2991641003355;5864.208331875142;5909.2908850938165;5916.142159386779;6000.279966403885;5847.590668653153;5858.681796595903;5905.970470147622;5931.093764055668;5939.851503712442;5744.913826292693;5811.157382179645;5813.82558523245;5825.854353641193;5854.268216472941;5700.942990570207;5905.025670764276;5919.23050003514;5936.387989284701;5965.492933100735;5757.5393968481585;5769.29805707309;5851.327097383855;5858.414158584107;5862.648241105548 09:42:48 INFO - PROCESS | 18267 | |5;yui.html;749.5090715581294;750.0661676213113;764.1059959846975;794.5034353529045;795.8090058385989;15159.545213643582;15242.618934526643;15677.608059798511;16233.91883040586;16274.186290685477;14423.350949207284;14437.494687685934;14528.200948947804;14529.782053269182;14576.271186440688;661.1471202149222;803.080472858578;808.8746244332137;812.8374325134968;812.9634166462523;778.3889646627399;796.4424902568196;801.5110782422746;802.2899733735657;806.9233422824823;836.3392919593514;839.911809260028;844.2486187293283;844.8986121665408;845.9154084591522;826.5247482697444;829.5396055189367;831.0484495252962;831.4844796226317;834.4450940124809;606.4875180472537;608.6409018678956;609.832296118571;610.8900397928371;611.8776244751023;15015.774763378558;15045;15144.621384465476;15146.697066058618;15155.545333640008;13394.598162055154;13470.057096003284;14119;14531.78202326966;14562;11509.366984815832;11522.711932201679;11524.308541487537;11545.30728156305;11881.881181188164;3761.492198553188;3867.9226415471812;3911.3741801311653;3994.6804255659767;4015.9196816063513;72726;73489.63255183744;73834.63082684606;74265;74404;9671.274654400948;10072.748181295527;10774.24580279373;11089.168312376443;11266.267692600119;20847.478813029797;20850.89574552148;20853.582928341348;20857.374278771662;20864.687029694567;8212.46618969765;8287.585620718939;8298.668053277801;8592.140785921358;8613.61238744258;4541.545845415432;4656.138614356287;4757.690750101232;4807.230843065163;4868.756562171877;3346.4143774839304;3417.043227896193;3426.4860270959057;3430.468277417004;3450.46517789743;578.2136294639287;583.2738240890119;588.9676067816312;589.4665327878276;590.9793157239562;597.3220394851787;597.9551533634994;673.4881490067486;681.9795406137824;718.964051797408;9475.052494750607;10010.14913732341;10103.7474063149;10209.9489502552;10306.845397319046;669.5112567825514;714.653393104344;715.2168375628678;752.9849403011909;764.8699721047435;4579.793909274091;4983.8006479741125;4988.326575912278;5063.924041139386;5068.391792984866;115250.4237478824;117051;117238;117295;118282;100455.99544004613;100709.49645251727;101337;103229;103658.48170759098;57367;58272.4172758267;71927.64036179785;89241;92558.99999999865;9373.953130234579;9523.380980236263;9597.136257736836;9622.226324902393;9644.180244679;50649;51023.48976510336;51132;51181;51930.74034629803;51110.23334649909;67229;71651.28348716446;72754.27245727475;76468.23531764612;12499.500019999097;12804.871951280367;12811.87188128144;12932.288724120264;13246.139000964906;14469.710605788036;14893.627659308604;15484.5354639361;15552.688946221238;15560;13893.30533473302;13936.79094813599;14301.713965720835;14302.427902884185;14613.780793287897;14021.158730476203;14207.502737404142;14396.928015359856;14409.495667651581;14503.492377766728;12526.185797923106;12827.166234195121;13053.477860885458;13114.409851556893;13234.536791212262;10514.631987880388;10544.26190166681;10684.89315106839;10962.671119866416;10977.341359518136;10450.634227801991;11133.498992545517;11185.832212516982;11817.409129543661;11961.581344652895 09:42:48 INFO - PROCESS | 18267 | __end_tp_report 09:42:48 INFO - PROCESS | 18267 | __start_cc_report 09:42:48 INFO - PROCESS | 18267 | _x_x_mozilla_cycle_collect,364 09:42:48 INFO - PROCESS | 18267 | __end_cc_report 09:42:48 INFO - PROCESS | 18267 | __startTimestamp1466181768867__endTimestamp 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | ------- Summary: start ------- 09:42:48 INFO - PROCESS | 18267 | Number of tests: 6 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | [#0] dojo.html Cycles:165 Average:5396.13 Median:5577.19 stddev:607.71 (10.9%) stddev-sans-first:582.10 09:42:48 INFO - PROCESS | 18267 | Values: 3093.1 3118.3 3132.7 3153.1 3154.6 5309.5 5311.7 5312.5 5446.4 5469.2 5310.2 5397.4 5445.8 5472.5 5484.8 4922.1 4944.1 4984.1 5106.3 5154.2 4921.4 5081.2 5099.3 5103.1 5111.3 4855.0 4920.1 4922.2 4964.3 4981.2 4931.2 4942.6 4946.2 4947.5 5018.7 4928.1 4930.8 4948.5 4971.7 4979.5 5187.8 5377.7 5385.3 5418.0 5473.5 5796.5 5842.5 5843.8 5864.1 5865.2 5672.4 5864.2 5872.6 5879.1 5882.2 5418.8 5445.0 5470.4 5489.6 5498.1 6004.3 6009.0 6012.9 6015.9 6025.8 5564.0 5597.6 5791.9 5804.6 5817.3 5728.2 5799.2 5799.6 5801.4 5856.3 5579.9 5727.1 5757.9 5773.7 5787.5 5609.9 5715.5 5796.0 5821.2 5834.6 4354.5 4458.7 4462.2 4503.1 4506.3 3959.3 3976.2 3988.0 3999.8 4014.4 5412.6 5516.4 5520.7 5523.5 5571.5 5840.2 5871.7 5900.4 5910.2 5962.7 5549.9 5577.2 5577.4 5596.3 5609.5 4871.0 4948.0 4948.7 4994.1 5031.7 6035.8 6045.5 6047.5 6059.0 6068.4 5786.1 5821.7 5823.1 5825.7 5850.2 5812.5 5942.1 5942.6 6000.6 6036.0 5658.3 5696.9 5697.5 5698.9 5725.5 5614.2 5745.9 5826.6 5827.2 5832.3 5526.4 5596.7 5656.1 5688.6 5758.7 5537.5 5548.8 5590.8 5635.6 5639.6 5503.2 5510.6 5550.9 5551.4 5559.0 5540.0 5616.7 5660.3 5736.8 5761.2 5564.4 5589.6 5613.0 5615.4 5629.0 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | [#1] ext.html Cycles:180 Average:63629.92 Median:40875.89 stddev:138528.11 (338.9%) stddev-sans-first:138835.87 09:42:48 INFO - PROCESS | 18267 | Values: 594.8 630.1 640.8 651.8 662.7 32796.2 36499.3 36509.3 36528.8 36619.6 41913.8 42016.4 42452.6 42503.4 42624.8 8747.0 8747.0 8824.3 8833.8 8905.7 8691.0 8706.0 8785.5 8787.3 8807.9 8807.6 8809.5 8818.4 8848.7 8855.5 8746.6 8747.9 8772.1 8815.3 8826.2 8710.9 8755.8 8760.1 8788.9 8791.6 40035.0 40221.8 40347.2 40445.2 40528.6 2993.0 3205.7 3456.3 3543.6 3625.5 32233.7 32362.8 32632.3 33718.7 34024.0 4298.5 4355.5 4356.9 4373.2 4398.3 323729.0 324016.0 325883.0 326182.0 326599.0 57750.4 57902.1 58061.4 58129.0 58193.0 34890.3 35671.6 35879.0 37334.8 37731.6 14203.4 14289.8 14322.5 14333.1 14349.1 12052.0 12056.6 12088.7 12096.8 12117.2 19060.0 19278.9 19311.7 19323.7 19515.5 7026.6 7283.7 7291.3 7394.7 7531.5 951.3 976.7 1018.6 1026.2 1125.8 32242.7 33914.2 36174.0 36533.0 36619.0 1094.4 1151.3 1176.4 1182.6 1184.0 16933.0 17233.8 17526.5 17529.6 17702.9 527945.0 539870.0 540334.0 864351.0 875635.0 56147.0 57193.4 57302.7 57323.7 57424.1 1336.2 1356.7 1357.0 1373.7 1386.1 31808.4 33348.7 33404.5 33901.8 33960.3 51532.0 51692.7 51996.7 52580.2 52584.7 460805.0 467257.0 471913.0 472719.0 473784.0 27867.6 27977.6 28320.9 28402.9 28433.9 46790.3 46792.8 47394.0 47861.8 47967.0 38967.8 40671.8 40777.0 40983.0 41148.8 38942.6 39843.4 40674.6 40905.2 40912.0 40968.4 43979.6 44127.0 45156.0 45218.3 39391.8 40846.6 41670.8 43517.6 43917.0 34479.0 34849.7 35002.6 35154.0 35183.5 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | [#2] jquery.html Cycles:180 Average:29300.97 Median:3593.67 stddev:74613.12 (2076.2%) stddev-sans-first:74790.84 09:42:48 INFO - PROCESS | 18267 | Values: 384.6 392.5 394.3 394.6 412.3 13740.8 17730.6 18076.9 19470.1 19502.2 18419.3 18474.2 19033.0 19382.4 19581.1 5500.7 5541.9 5669.0 5972.7 5990.9 5393.7 5737.0 5831.1 5857.6 5914.0 5747.3 5778.1 5792.1 5810.5 5815.6 5495.2 5784.9 5825.2 5892.0 5921.6 5469.2 5627.5 5644.8 5662.3 5704.2 21971.3 22155.1 22852.7 22858.7 23181.0 2336.1 2361.0 2419.5 2444.8 2535.7 13866.4 14490.9 15325.9 15655.6 16183.4 1934.7 1939.1 1950.6 2029.0 2124.8 93563.6 95569.0 96067.5 96392.0 97403.0 16671.0 17632.8 17881.7 18067.7 18115.7 31763.4 31800.4 31923.9 32067.5 32196.0 9455.3 9675.0 9776.4 9798.7 9824.5 7584.7 7631.0 8085.7 8110.6 8233.2 8971.6 8997.8 9011.9 9075.4 9271.7 3543.0 3546.3 3549.5 3579.2 3608.2 857.4 1004.6 1016.3 1036.0 1052.8 19088.6 19372.9 19454.7 19578.9 19612.0 935.1 959.4 1003.5 1006.0 1076.1 10314.0 11031.2 11077.6 11086.9 11121.0 439905.0 446225.0 450905.0 452829.0 454185.0 92220.0 97733.5 99229.0 99849.0 100601.0 936.8 941.7 948.3 951.2 960.0 16954.7 16980.9 17043.4 17077.6 17236.2 40566.8 40651.0 40818.4 41521.6 41584.4 58135.7 58961.0 59740.7 59820.4 59919.7 7940.6 8074.0 8182.0 8330.0 8398.3 12692.9 12765.9 13011.3 13049.2 13101.5 11183.8 11490.2 11561.0 11739.2 11741.3 10428.8 10972.6 11514.3 11522.5 11569.5 11299.3 11332.8 11546.3 11739.1 11871.9 7717.9 8076.0 8206.4 8213.5 8335.8 5814.7 11121.3 11299.0 11674.0 11711.6 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | [#3] mootools.html Cycles:180 Average:5565.70 Median:4555.27 stddev:3224.86 (70.8%) stddev-sans-first:3218.82 09:42:48 INFO - PROCESS | 18267 | Values: 1414.9 1426.0 1503.2 1650.8 1653.7 7643.8 7927.6 8246.4 8863.6 8873.2 8264.3 8273.5 8295.0 8329.4 8409.2 2071.3 2117.1 2117.8 2118.0 2119.3 2025.9 2034.1 2043.5 2063.0 2070.1 2033.9 2048.9 2056.5 2060.8 2063.2 2020.6 2047.1 2051.1 2054.5 2055.6 1993.4 2006.2 2015.1 2045.1 2048.8 8374.5 8413.2 8425.5 8426.1 8464.1 4862.3 4999.2 5003.8 5013.9 5017.4 3225.7 3257.5 3311.2 3374.5 3377.5 1080.3 1099.1 1115.8 1126.5 1130.5 11972.3 12078.4 12119.5 12130.9 12140.3 4338.2 4346.5 4419.7 4422.6 4513.9 9541.1 9575.7 9614.2 9627.5 9644.5 4805.6 4824.0 4839.6 4839.8 4842.2 4062.8 4465.2 4517.0 4522.5 4588.0 3537.5 3539.3 3545.9 3599.8 3633.1 1076.9 1081.3 1088.2 1092.1 1097.9 904.0 958.2 995.1 997.6 1010.8 6111.6 6126.5 6180.8 6182.8 6190.2 411.3 420.7 421.1 1013.4 1043.8 4128.9 4150.3 4173.9 4204.5 4236.1 10377.4 10386.7 10454.9 10502.1 10548.0 10339.8 10375.3 10382.6 10385.3 10392.5 7596.5 7699.6 7710.0 7795.7 7824.1 5976.2 6216.4 6225.2 6278.7 6366.0 9751.1 9944.0 9955.4 10034.6 10060.5 9781.0 10032.0 10063.5 10143.2 10234.9 6697.9 7282.6 7408.1 7426.2 7687.7 8393.3 8485.7 8512.2 8565.1 8571.6 7163.4 7237.3 7361.4 7500.5 7553.6 7412.6 7505.8 7604.0 7632.2 7759.4 6460.0 6479.0 6501.7 6507.3 6546.3 4855.0 4970.9 4986.6 5073.6 5111.3 4948.1 5012.4 5066.6 5203.4 5310.9 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | [#4] prototype.html Cycles:180 Average:4853.19 Median:5499.93 stddev:1467.84 (26.7%) stddev-sans-first:1431.71 09:42:48 INFO - PROCESS | 18267 | Values: 304.6 316.4 320.2 320.3 321.6 5497.6 5523.5 5639.9 5731.5 5734.0 5502.3 5556.4 5586.8 5613.5 5618.7 4282.5 4296.9 4297.9 4301.2 4330.7 4115.2 4325.6 4333.5 4344.7 4360.7 4281.0 4297.3 4305.2 4308.9 4322.0 4312.5 4324.4 4333.2 4338.1 4352.7 3639.7 3730.8 3778.8 3779.3 3792.4 5340.0 5431.0 5449.8 5481.3 5483.2 4779.9 4852.8 4859.3 4942.0 4948.0 5575.4 5771.3 5795.5 5853.9 5890.4 4111.2 4113.3 4120.0 4132.2 4132.3 6129.8 6173.3 6180.5 6198.8 6223.8 4108.1 4167.2 4206.6 4208.7 4233.4 4263.8 4281.3 4281.5 4285.4 4295.0 4891.2 4910.8 4923.9 4939.3 4940.5 5736.7 5878.2 5922.2 5950.7 5960.7 1455.5 1463.9 1467.5 1468.1 1474.6 867.9 906.2 909.0 920.6 925.0 4988.0 5024.6 5045.0 5045.9 5124.4 5322.7 5378.4 5400.6 5437.5 5443.9 4869.7 4927.5 5035.0 5053.5 5076.8 2843.6 2896.9 2904.9 2910.5 2938.8 5523.3 5591.8 5611.4 5620.7 5729.9 5505.0 5676.7 6182.9 6193.3 6200.5 6339.8 6351.1 6353.8 6395.4 6398.6 5949.5 6069.0 6090.0 6106.3 6125.5 5948.7 6037.3 6046.9 6048.2 6071.2 5775.2 6348.7 6355.6 6398.3 6404.5 4052.4 4111.4 4120.5 4129.5 4134.2 6071.5 6097.9 6113.6 6152.1 6198.3 5840.3 5864.2 5909.3 5916.1 6000.3 5847.6 5858.7 5906.0 5931.1 5939.9 5744.9 5811.2 5813.8 5825.9 5854.3 5700.9 5905.0 5919.2 5936.4 5965.5 5757.5 5769.3 5851.3 5858.4 5862.6 09:42:48 INFO - PROCESS | 18267 | 09:42:48 INFO - PROCESS | 18267 | [#5] yui.html Cycles:180 Average:20306.27 Median:3953.03 stddev:29316.78 (741.6%) stddev-sans-first:29362.24 09:42:48 INFO - PROCESS | 18267 | Values: 749.5 750.1 764.1 794.5 795.8 15159.5 15242.6 15677.6 16233.9 16274.2 14423.4 14437.5 14528.2 14529.8 14576.3 661.1 803.1 808.9 812.8 813.0 778.4 796.4 801.5 802.3 806.9 836.3 839.9 844.2 844.9 845.9 826.5 829.5 831.0 831.5 834.4 606.5 608.6 609.8 610.9 611.9 15015.8 15045.0 15144.6 15146.7 15155.5 13394.6 13470.1 14119.0 14531.8 14562.0 11509.4 11522.7 11524.3 11545.3 11881.9 3761.5 3867.9 3911.4 3994.7 4015.9 72726.0 73489.6 73834.6 74265.0 74404.0 9671.3 10072.7 10774.2 11089.2 11266.3 20847.5 20850.9 20853.6 20857.4 20864.7 8212.5 8287.6 8298.7 8592.1 8613.6 4541.5 4656.1 4757.7 4807.2 4868.8 3346.4 3417.0 3426.5 3430.5 3450.5 578.2 583.3 589.0 589.5 591.0 597.3 598.0 673.5 682.0 719.0 9475.1 10010.1 10103.7 10209.9 10306.8 669.5 714.7 715.2 753.0 764.9 4579.8 4983.8 4988.3 5063.9 5068.4 115250.4 117051.0 117238.0 117295.0 118282.0 100456.0 100709.5 101337.0 103229.0 103658.5 57367.0 58272.4 71927.6 89241.0 92559.0 9374.0 9523.4 9597.1 9622.2 9644.2 50649.0 51023.5 51132.0 51181.0 51930.7 51110.2 67229.0 71651.3 72754.3 76468.2 12499.5 12804.9 12811.9 12932.3 13246.1 14469.7 14893.6 15484.5 15552.7 15560.0 13893.3 13936.8 14301.7 14302.4 14613.8 14021.2 14207.5 14396.9 14409.5 14503.5 12526.2 12827.2 13053.5 13114.4 13234.5 10514.6 10544.3 10684.9 10962.7 10977.3 10450.6 11133.5 11185.8 11817.4 11961.6 09:42:48 INFO - PROCESS | 18267 | -------- Summary: end -------- 09:42:48 INFO - PROCESS | 18267 | 09:42:49 INFO - TEST-INFO | 18267: exit 0 09:42:49 INFO - TEST-OK | dromaeo_css | took 1111947ms 09:42:49 INFO - TEST-START | kraken 09:42:49 INFO - operating with platform_type : linux_ 09:42:49 INFO - Initialising browser for kraken test... 09:42:49 INFO - TEST-INFO | started process 18507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXKRMGK/profile http://localhost:42772/getInfo.html) 09:42:54 INFO - PROCESS | 18507 | __metrics Screen width/height:1600/1200 09:42:54 INFO - PROCESS | 18507 | colorDepth:24 09:42:54 INFO - PROCESS | 18507 | Browser inner width/height: 1024/697 09:42:54 INFO - PROCESS | 18507 | __metrics 09:42:54 ERROR - PROCESS | 18507 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 09:42:55 INFO - TEST-INFO | 18507: exit 0 09:42:55 INFO - Browser initialized. 09:42:55 INFO - Running cycle 1/1 for kraken test... 09:42:55 INFO - TEST-INFO | started process 18624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXKRMGK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:07 INFO - PROCESS | 18624 | RSS: Main: 184606720 09:43:07 INFO - PROCESS | 18624 | 09:43:10 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42772/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:11 INFO - PROCESS | 18624 | RSS: Main: 191234048 09:43:11 INFO - PROCESS | 18624 | 09:43:13 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42772/tests/kraken/driver.html?testName=audio-dft) 09:43:14 INFO - PROCESS | 18624 | RSS: Main: 190164992 09:43:14 INFO - PROCESS | 18624 | 09:43:17 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42772/tests/kraken/driver.html?testName=audio-fft) 09:43:18 INFO - PROCESS | 18624 | RSS: Main: 184913920 09:43:18 INFO - PROCESS | 18624 | 09:43:20 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42772/tests/kraken/driver.html?testName=audio-oscillator) 09:43:20 INFO - PROCESS | 18624 | RSS: Main: 185901056 09:43:20 INFO - PROCESS | 18624 | 09:43:23 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42772/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:23 INFO - PROCESS | 18624 | RSS: Main: 186372096 09:43:23 INFO - PROCESS | 18624 | 09:43:26 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42772/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:27 INFO - PROCESS | 18624 | RSS: Main: 185892864 09:43:27 INFO - PROCESS | 18624 | 09:43:30 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42772/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:31 INFO - PROCESS | 18624 | RSS: Main: 184254464 09:43:31 INFO - PROCESS | 18624 | 09:43:34 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42772/tests/kraken/driver.html?testName=json-parse-financial) 09:43:35 INFO - PROCESS | 18624 | RSS: Main: 185753600 09:43:35 INFO - PROCESS | 18624 | 09:43:36 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42772/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:37 INFO - PROCESS | 18624 | RSS: Main: 186294272 09:43:37 INFO - PROCESS | 18624 | 09:43:38 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:39 INFO - PROCESS | 18624 | RSS: Main: 186175488 09:43:39 INFO - PROCESS | 18624 | 09:43:41 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:42 INFO - PROCESS | 18624 | RSS: Main: 186880000 09:43:42 INFO - PROCESS | 18624 | 09:43:45 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:45 INFO - PROCESS | 18624 | RSS: Main: 186748928 09:43:45 INFO - PROCESS | 18624 | 09:43:48 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:49 INFO - PROCESS | 18624 | RSS: Main: 186605568 09:43:49 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | Cycle 1(1): loaded http://localhost:42772/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42772/tests/kraken/driver.html?testName=ai-astar) 09:43:50 INFO - PROCESS | 18624 | RSS: Main: 187355136 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | __start_tp_report 09:43:50 INFO - PROCESS | 18624 | _x_x_mozilla_page_load 09:43:50 INFO - PROCESS | 18624 | _x_x_mozilla_page_load_details 09:43:50 INFO - PROCESS | 18624 | |i|pagename|runs| 09:43:50 INFO - PROCESS | 18624 | |0;ai-astar;112;105;111;110;111;110;110;111;111;109 09:43:50 INFO - PROCESS | 18624 | |1;audio-beat-detection;155;124;150;177;126;151;160;126;181;128 09:43:50 INFO - PROCESS | 18624 | |2;audio-dft;163;163;161;163;164;169;164;163;161;160 09:43:50 INFO - PROCESS | 18624 | |3;audio-fft;77;76;75;170;84;75;75;76;167;77 09:43:50 INFO - PROCESS | 18624 | |4;audio-oscillator;86;86;145;85;91;86;140;84;85;140 09:43:50 INFO - PROCESS | 18624 | |5;imaging-gaussian-blur;117;118;118;118;118;118;117;117;118;118 09:43:50 INFO - PROCESS | 18624 | |6;imaging-darkroom;146;148;146;146;148;146;147;147;147;148 09:43:50 INFO - PROCESS | 18624 | |7;imaging-desaturate;96;98;96;95;95;95;96;96;95;95 09:43:50 INFO - PROCESS | 18624 | |8;json-parse-financial;61;54;56;54;55;56;54;54;53;55 09:43:50 INFO - PROCESS | 18624 | |9;json-stringify-tinderbox;63;62;63;63;64;62;64;63;63;63 09:43:50 INFO - PROCESS | 18624 | |10;stanford-crypto-aes;79;79;82;85;81;81;86;86;109;80 09:43:50 INFO - PROCESS | 18624 | |11;stanford-crypto-ccm;135;143;122;135;121;143;124;130;127;127 09:43:50 INFO - PROCESS | 18624 | |12;stanford-crypto-pbkdf2;165;163;164;159;161;165;159;159;159;159 09:43:50 INFO - PROCESS | 18624 | |13;stanford-crypto-sha256-iterative;65;63;66;64;64;64;63;64;62;62 09:43:50 INFO - PROCESS | 18624 | __end_tp_report 09:43:50 INFO - PROCESS | 18624 | __start_cc_report 09:43:50 INFO - PROCESS | 18624 | _x_x_mozilla_cycle_collect,901 09:43:50 INFO - PROCESS | 18624 | __end_cc_report 09:43:50 INFO - PROCESS | 18624 | __startTimestamp1466181830971__endTimestamp 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | ------- Summary: start ------- 09:43:50 INFO - PROCESS | 18624 | Number of tests: 14 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:1.94 (1.8%) stddev-sans-first:1.92 09:43:50 INFO - PROCESS | 18624 | Values: 112.0 105.0 111.0 110.0 111.0 110.0 110.0 111.0 111.0 109.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:153.00 stddev:21.29 (13.9%) stddev-sans-first:22.42 09:43:50 INFO - PROCESS | 18624 | Values: 155.0 124.0 150.0 177.0 126.0 151.0 160.0 126.0 181.0 128.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:2.47 (1.5%) stddev-sans-first:2.62 09:43:50 INFO - PROCESS | 18624 | Values: 163.0 163.0 161.0 163.0 164.0 169.0 164.0 163.0 161.0 160.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#3] audio-fft Cycles:10 Average:95.20 Median:76.00 stddev:38.73 (51.0%) stddev-sans-first:40.51 09:43:50 INFO - PROCESS | 18624 | Values: 77.0 76.0 75.0 170.0 84.0 75.0 75.0 76.0 167.0 77.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#4] audio-oscillator Cycles:10 Average:102.80 Median:85.50 stddev:26.92 (31.5%) stddev-sans-first:27.86 09:43:50 INFO - PROCESS | 18624 | Values: 86.0 86.0 145.0 85.0 91.0 86.0 140.0 84.0 85.0 140.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 09:43:50 INFO - PROCESS | 18624 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 09:43:50 INFO - PROCESS | 18624 | Values: 146.0 148.0 146.0 146.0 148.0 146.0 147.0 147.0 147.0 148.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.95 (1.0%) stddev-sans-first:1.00 09:43:50 INFO - PROCESS | 18624 | Values: 96.0 98.0 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.25 (4.1%) stddev-sans-first:1.01 09:43:50 INFO - PROCESS | 18624 | Values: 61.0 54.0 56.0 54.0 55.0 56.0 54.0 54.0 53.0 55.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#9] json-stringify-tinderbox Cycles:10 Average:63.00 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 09:43:50 INFO - PROCESS | 18624 | Values: 63.0 62.0 63.0 63.0 64.0 62.0 64.0 63.0 63.0 63.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:81.50 stddev:8.92 (10.9%) stddev-sans-first:9.21 09:43:50 INFO - PROCESS | 18624 | Values: 79.0 79.0 82.0 85.0 81.0 81.0 86.0 86.0 109.0 80.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#11] stanford-crypto-ccm Cycles:10 Average:130.70 Median:132.50 stddev:8.04 (6.1%) stddev-sans-first:8.38 09:43:50 INFO - PROCESS | 18624 | Values: 135.0 143.0 122.0 135.0 121.0 143.0 124.0 130.0 127.0 127.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.30 Median:162.00 stddev:2.67 (1.6%) stddev-sans-first:2.47 09:43:50 INFO - PROCESS | 18624 | Values: 165.0 163.0 164.0 159.0 161.0 165.0 159.0 159.0 159.0 159.0 09:43:50 INFO - PROCESS | 18624 | 09:43:50 INFO - PROCESS | 18624 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.25 (2.0%) stddev-sans-first:1.24 09:43:50 INFO - PROCESS | 18624 | Values: 65.0 63.0 66.0 64.0 64.0 64.0 63.0 64.0 62.0 62.0 09:43:50 INFO - PROCESS | 18624 | -------- Summary: end -------- 09:43:50 INFO - PROCESS | 18624 | 09:43:51 INFO - TEST-INFO | 18624: exit 0 09:43:51 INFO - TEST-OK | kraken | took 62244ms 09:43:51 INFO - SUITE-END | took 1174s 09:43:52 INFO - Completed test suite (00:19:34) 09:43:52 INFO - javascript benchmark 09:43:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7309.0365746866255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.103000129962, 3118.3451475190195, 3132.6867313268667, 3153.132888455674, 3154.558361829346, 5309.548688361489, 5311.73441327934, 5312.521873031426, 5446.428125046872, 5469.234307196995, 5310.20346947958, 5397.379301380342, 5445.754941027653, 5472.50747432731, 5484.8354549363485, 4922.114019476493, 4944.060628480577, 4984.102861484949, 5106.285120083191, 5154.201098829687, 4921.360223171001, 5081.161608334621, 5099.286099946011, 5103.132467480518, 5111.284420181178, 4854.951450485521, 4920.089783390084, 4922.212446008622, 4964.255361695757, 4981.203007518798, 4931.211006238985, 4942.555170034714, 4946.233333833262, 4947.480514545993, 5018.723970181639, 4928.063667903087, 4930.802767889316, 4948.455669876311, 4971.701697898102, 4979.4771548987555, 5187.766550505236, 5377.677339359651, 5385.272988146589, 5418.0, 5473.534749546254, 5796.50729687977, 5842.503387212092, 5843.824685259449, 5864.1203819427, 5865.208196893407, 5672.432756724335, 5864.237649105632, 5872.647641141502, 5879.059350503899, 5882.205902203191, 5418.810341638024, 5445.047116754552, 5470.370907345667, 5489.615726899158, 5498.092814685572, 6004.309504406961, 6008.969955150196, 6012.879742405127, 6015.909761353583, 6025.8192254232445, 5563.972180139073, 5597.608167428241, 5791.913121303184, 5804.593678442468, 5817.272840894888, 5728.198052272685, 5799.246098007232, 5799.5650326225705, 5801.448862358069, 5856.326522449887, 5579.916301255404, 5727.083666613322, 5757.8560535986935, 5773.653580785166, 5787.5080618147085, 5609.915851262234, 5715.514181294553, 5795.971020144872, 5821.155932389865, 5834.620749651259, 4354.455693038371, 4458.665600080007, 4462.219111655448, 4503.144402563503, 4506.324051392252, 3959.307121253769, 3976.2445135424177, 3987.9631295863283, 3999.7800120993625, 4014.437978682987, 5412.5940554458575, 5516.393196748354, 5520.66875987442, 5523.475269849358, 5571.498565129158, 5840.153177789197, 5871.706414679249, 5900.4099590041515, 5910.202122713465, 5962.672053037125, 5549.916751248735, 5577.191307260425, 5577.414371491016, 5596.3284405871555, 5609.523190528851, 4870.951290487121, 4948.035133149001, 4948.678335908155, 4994.051130285234, 5031.698098114125, 6035.818925432244, 6045.486133678686, 6047.455728984324, 6058.969705151446, 6068.423499767515, 5786.103154011051, 5821.679807610622, 5823.097419899922, 5825.679587622722, 5850.180974663635, 5812.534997200299, 5942.10868369748, 5942.554308426972, 6000.639961602318, 6035.969820150871, 5658.264425624642, 5696.857578560569, 5697.515711164431, 5698.857528561819, 5725.484706376446, 5614.157876318585, 5745.885082298247, 5826.592138550261, 5827.155062515996, 5832.3292821326095, 5526.447355264441, 5596.720163991866, 5656.123300888369, 5688.601797874109, 5758.654480731169, 5537.529310008695, 5548.805791797267, 5590.8043218487155, 5635.633683810704, 5639.605227634191, 5503.2020357048805, 5510.641808282448, 5550.861228469321, 5551.417101204477, 5559.0, 5539.972300138474, 5616.69108199053, 5660.264165658438, 5736.770529178786, 5761.222234998221, 5564.443555644403, 5589.636673616202, 5612.971935140298, 5615.3823079462045, 5629.043062679272], "value": 5355.363145390942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.8453402115451, 630.1241274628267, 640.823773462298, 651.8142329436112, 662.7315937045498, 32796.18009549763, 36499.27001459969, 36509.26981460369, 36528.81735591322, 36619.633803661956, 41913.79043104788, 42016.369754453706, 42452.57547424533, 42503.36244956328, 42624.78687606558, 8746.956265218681, 8747.0, 8824.294056475499, 8833.823323533525, 8905.73282801517, 8690.956545217297, 8706.0, 8785.472871627691, 8787.25308348791, 8807.867881981776, 8807.559622018905, 8809.471431714117, 8818.426802257865, 8848.690295839648, 8855.512946787923, 8746.606402711894, 8747.868781968276, 8772.12278772124, 8815.294776417903, 8826.205641492264, 8710.912890871074, 8755.77419161318, 8760.123987601253, 8788.912110878873, 8791.560421978875, 40035.0, 40221.79889100565, 40347.19305613871, 40445.191096177914, 40528.59471405278, 2993.0, 3205.6954589313978, 3456.2914602506426, 3543.553073955439, 3625.546806649169, 32233.6776632233, 32362.83818580892, 32632.347353053043, 33718.662813372044, 34024.0, 4298.475517615527, 4355.499117601453, 4356.934645980313, 4373.169097871394, 4398.34024896265, 323729.0, 324016.0, 325883.0, 326182.0, 326599.0, 57750.4224957745, 57902.13146802801, 58061.4193858056, 58129.0, 58193.0, 34890.30219395598, 35671.64328356683, 35879.0, 37334.813325933195, 37731.62268377336, 14203.431862725582, 14289.785653215211, 14322.498712545012, 14333.14001159913, 14349.139051656934, 12052.035837133008, 12056.578019769266, 12088.697782555331, 12096.81854772179, 12117.21238119537, 19060.0, 19278.885931596873, 19311.710324345146, 19323.710144347846, 19515.51211219731, 7026.613536255452, 7283.672234749449, 7291.270872912666, 7394.704211831574, 7531.472796904164, 951.2817822543935, 976.7069879036403, 1018.6180182431589, 1026.235454586338, 1125.7692173104494, 32242.677573224435, 33914.15214619605, 36174.0, 36533.0, 36619.0, 1094.370736826328, 1151.2862025544216, 1176.4118440105788, 1182.5920057580122, 1184.0350114656528, 16933.0, 17233.827661723473, 17526.474205773848, 17529.56176095608, 17702.91148544249, 527945.0, 539870.0, 540334.0, 864351.0, 875635.0, 56147.0, 57193.42806571964, 57302.7134864323, 57323.713381432826, 57424.13863792046, 1336.211635135275, 1356.6608347912825, 1357.0365040821127, 1373.6565858535366, 1386.105961654727, 31808.36383272368, 33348.66651333456, 33404.498932516515, 33901.83049084739, 33960.320793583494, 51532.0, 51692.74153629208, 51996.74001629968, 52580.21129682981, 52584.737076315905, 460805.0, 467257.0, 471913.0, 472719.0, 473784.0, 27867.581986270627, 27977.580336295377, 28320.858395707888, 28402.85798570994, 28433.857830710713, 46790.298145528526, 46792.7660361696, 47394.0, 47861.76069119771, 47967.0, 38967.805160974014, 40671.796641016605, 40777.0, 40983.0, 41148.79425602853, 38942.6105738939, 39843.40234896537, 40674.59325406826, 40905.18189636131, 40912.0, 40968.38547421851, 43979.560204397545, 44127.0, 45156.0, 45218.32172517481, 39391.80304098461, 40846.59153408428, 41670.79164604157, 43517.56482435135, 43917.0, 34479.0, 34849.65150348464, 35002.64997349994, 35154.0, 35183.472247915786], "value": 20012.756666352005, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.5692824037078, 392.49956305710236, 394.26863168821836, 394.57780175212514, 412.30320757919117, 13740.793888091686, 17730.556736081606, 18076.909615451903, 19470.123844427017, 19502.219911203552, 18419.26322947084, 18474.16866241019, 19033.0, 19382.418527444162, 19581.118849651764, 5500.669959802414, 5541.9168712469145, 5668.971655141719, 5972.73122709477, 5990.8502287442725, 5393.73031348433, 5737.0, 5831.096180092071, 5857.6485410875275, 5914.0, 5747.33905600855, 5778.075507918734, 5792.073268277077, 5810.477057064863, 5815.62198457101, 5495.203195536645, 5784.884302313952, 5825.242718446596, 5892.027815410452, 5921.585489015771, 5469.234307196995, 5627.493525582717, 5644.8306550803545, 5662.2639056922335, 5704.172894930211, 21971.34085977423, 22155.113795448164, 22852.65721014186, 22858.657120143213, 23181.0, 2336.0655737704883, 2361.0437772702085, 2419.52819200256, 2444.841085329466, 2535.7210706822234, 13866.4453421863, 14490.927545362205, 15325.923370383076, 15655.608609784733, 16183.43357982465, 1934.6517626827165, 1939.078937504674, 1950.5806251655963, 2029.046348216336, 2124.7556530998977, 93563.62002695538, 95569.0, 96067.51966240125, 96392.0, 97403.0, 16671.0, 17632.823671763374, 17881.7317740234, 18067.72898406525, 18115.72826407605, 31763.364732705217, 31800.363992720017, 31923.92494487851, 32067.51898721521, 32196.0, 9455.29085318604, 9675.0, 9776.413415195111, 9798.706038818847, 9824.459654718916, 7584.696612135564, 7631.0, 8085.7017149240755, 8110.63502142405, 8233.17668233172, 8971.551422428984, 8997.795540092719, 9011.909880901107, 9075.364724469357, 9271.721848344425, 3542.9645703542633, 3546.308469848355, 3549.4512624208296, 3579.1767893384667, 3608.1701208722143, 857.4340934982881, 1004.5529739265957, 1016.3343010328247, 1035.9741006474749, 1052.7631282961427, 19088.61822763565, 19372.903135484234, 19454.70817937732, 19578.902105489666, 19612.0, 935.0742764663071, 959.4291396619001, 1003.533356988989, 1005.9547320370601, 1076.0853274716585, 10314.0, 11031.2278140531, 11077.556897724, 11086.891310868848, 11121.0, 439905.0, 446225.0, 450905.0, 452829.0, 454185.0, 92220.0, 97733.51133244288, 99229.0, 99849.0, 100601.0, 936.836053690615, 941.7457286532734, 948.3029972969862, 951.2057432044182, 959.9664011759555, 16954.660906782043, 16980.915095424443, 17043.40348087811, 17077.57306067358, 17236.224369903633, 40566.79716601516, 40651.0, 40818.387724183565, 41521.584784151775, 41584.37623435591, 58135.70932145312, 58961.0, 59740.701296494975, 59820.40179598148, 59919.700401497714, 7940.642671079931, 8074.0, 8181.959090204511, 8329.958350208453, 8398.286145677686, 12692.936535317263, 12765.93617031909, 13011.284379359226, 13049.217046977212, 13101.475940962255, 11183.776324473627, 11490.195686301879, 11561.0, 11739.23694959825, 11741.29552226869, 10428.791424171626, 10972.615958441416, 11514.30914145154, 11522.539098436304, 11569.479373428385, 11299.322040677585, 11332.773344532898, 11546.307221566733, 11739.119566032752, 11871.881281187078, 7717.884231736416, 8075.959620201861, 8206.425550211428, 8213.507189568645, 8335.833283334421, 5814.651120932757, 11121.27711698737, 11299.039581635325, 11674.0, 11711.590094346657], "value": 9965.759459506939, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.9221792801397, 1426.0089237979605, 1503.1582313904207, 1650.8349165083487, 1653.7023335799565, 7643.770686879388, 7927.563983980879, 8246.381521385898, 8863.601137948799, 8873.201411872938, 8264.33885289177, 8273.544955027472, 8295.046069701986, 8329.37529685273, 8409.159084091587, 2071.2957594417894, 2117.068489864462, 2117.819985301251, 2117.957640847182, 2119.2688522459725, 2025.8885761283123, 2034.1354924157247, 2043.5095577061472, 2063.030375723408, 2070.0684691888637, 2033.9084741186682, 2048.9077991490417, 2056.4858785303672, 2060.763012253595, 2063.174730107954, 2020.5554777948976, 2047.0788145334511, 2051.148773259103, 2054.5171884607107, 2055.578606385695, 1993.401979406187, 2006.2276023730822, 2015.093208056366, 2045.110376986001, 2048.7643920948985, 8374.539400332978, 8413.158684131538, 8425.452345597578, 8426.07313195548, 8464.111268316861, 4862.270659401082, 4999.175136102575, 5003.799848006075, 5013.874653133665, 5017.397912250517, 3225.6935591118804, 3257.4950882613234, 3311.172206948263, 3374.5275661407422, 3377.493375993596, 1080.254624309224, 1099.0987390339924, 1115.7712668902855, 1126.4649291586513, 1130.5477808876433, 11972.281663100155, 12078.396080195955, 12119.454624541917, 12130.939345303304, 12140.271583705005, 4338.154059958341, 4346.478422589246, 4419.712718673276, 4422.646188304928, 4513.864584062483, 9541.141297283279, 9575.664851730156, 9614.18279446255, 9627.518624068769, 9644.469554174448, 4805.567498925114, 4823.95176048235, 4839.564439200419, 4839.782209800567, 4842.225243960949, 4062.837486500566, 4465.151621191963, 4516.954830451719, 4522.5025247222775, 4588.036512332381, 3537.46937959303, 3539.309834582232, 3545.94681079784, 3599.8200089995394, 3633.0554055945645, 1076.9138468922467, 1081.34578579958, 1088.1838621034224, 1092.1044743310408, 1097.8956999085074, 904.0372003815914, 958.242988039455, 995.1143482300758, 997.5754751126666, 1010.777628921636, 6111.572189946661, 6126.540509461808, 6180.81457556274, 6182.845428864314, 6190.226221722285, 411.2699957575268, 420.7265277569604, 421.11355596469605, 1013.3869009249445, 1043.7703705184847, 4128.91742165155, 4150.294449943517, 4173.916521669549, 4204.453421055243, 4236.131593023423, 10377.429241391645, 10386.740331491623, 10454.895451045544, 10502.107320877658, 10548.0, 10339.844902326471, 10375.27373083892, 10382.584696612052, 10385.273030887765, 10392.480375981171, 7596.506227095221, 7699.576523291161, 7709.9614501927135, 7795.727149549739, 7824.061112666403, 5976.193213916065, 6216.378362163929, 6225.190725205694, 6278.686065696788, 6365.96817015912, 9751.122398984126, 9943.950280248553, 9955.352902061342, 10034.64878729241, 10060.49697515136, 9780.951095244764, 10032.0, 10063.496825158567, 10143.188544916242, 10234.948825256124, 6697.899531507129, 7282.599457029914, 7408.148062972611, 7426.18311985692, 7687.654055567625, 8393.32853371741, 8485.660573576988, 8512.191341822518, 8565.05784363707, 8571.57142142903, 7163.4269258460245, 7237.276272372721, 7361.4110871129105, 7500.512466689648, 7553.622318883924, 7412.592307423143, 7505.812354691177, 7604.049493813273, 7632.236776322324, 7759.418043646636, 6460.0, 6478.967605161944, 6501.674916254263, 6507.316731743288, 6546.345365463416, 4854.975725121351, 4970.925436118533, 4986.551210391082, 5073.594112471067, 5111.309973153577, 4948.05986862495, 5012.423571289349, 5066.59467242627, 5203.375594928632, 5310.920336195038], "value": 4382.485673720358, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.63900278170354, 316.4083164482418, 320.2330418647338, 320.34969012903804, 321.6237002706833, 5497.5601951843855, 5523.475269849358, 5639.915401268984, 5731.51282141018, 5734.0, 5502.30387110316, 5556.416576259495, 5586.804461843836, 5613.494785469307, 5618.719064046792, 4282.464691913511, 4296.935545966813, 4297.914041719179, 4301.19349873054, 4330.7401555906745, 4115.218108559364, 4325.632321252698, 4333.4799824021, 4344.695871289011, 4360.694751367406, 4281.036766727492, 4297.333913243437, 4305.182015417061, 4308.9353659695125, 4321.9783901080455, 4312.547182545819, 4324.437823083011, 4333.176696427684, 4338.112920879427, 4352.695311328208, 3639.6906262967677, 3730.794806285653, 3778.848846046155, 3779.261539691745, 3792.393217085281, 5340.0, 5431.049566325877, 5449.836504904859, 5481.342238931354, 5483.2049352844015, 4779.880502987418, 4852.757362131879, 4859.2954021666665, 4942.0, 4948.0, 5575.386707462176, 5771.278590176228, 5795.478406943354, 5853.88292234153, 5890.440408161217, 4111.177764447122, 4113.321301985169, 4120.011197312653, 4132.173565286955, 4132.2561938850995, 6129.7854575090105, 6173.2900716417735, 6180.505559555225, 6198.81403557894, 6223.786361659479, 4108.130800485832, 4167.208230436268, 4206.600372964564, 4208.705390622688, 4233.428487154195, 4263.8081286342185, 4281.314989601711, 4281.486221653359, 4285.442892423965, 4294.957050429518, 4891.241857512091, 4910.779014944336, 4923.926141107886, 4939.259111133287, 4940.456549779521, 5736.6558006519745, 5878.206442130343, 5922.230110085661, 5950.672713000827, 5960.701964901824, 1455.5415044261024, 1463.9093875062933, 1467.4570408948757, 1468.0971202710257, 1474.6018574984694, 867.8568036273944, 906.1572737354323, 908.9636414543344, 920.5535315372039, 924.9722508324761, 4987.975060124676, 5024.598032157419, 5045.0, 5045.899082018339, 5124.359455068116, 5322.733863306897, 5378.354597448331, 5400.567954563626, 5437.510624043855, 5443.863903402367, 4869.659123861366, 4927.457979622239, 5035.015334818503, 5053.534475002281, 5076.8476945690945, 2843.6018957345987, 2896.898608548691, 2904.8547572621283, 2910.4906641338102, 2938.779591530601, 5523.28197334344, 5591.804286849941, 5611.354694210137, 5620.662760234317, 5729.88540229193, 5504.981578408007, 5676.716164191774, 6182.907256391158, 6193.287771906198, 6200.472959798378, 6339.809805705836, 6351.142595749607, 6353.777617783263, 6395.424411802867, 6398.61608303494, 5949.494292984971, 6068.997230913699, 6089.969550152221, 6106.3283038866575, 6125.540584456273, 5948.702564871825, 6037.335893051849, 6046.879062418639, 6048.243969503812, 6071.241094863142, 5775.249217601685, 6348.682565871595, 6355.586886852339, 6398.296187419473, 6404.455621272244, 4052.4326594276235, 4111.362738775495, 4120.454829438961, 4129.545749967561, 4134.1731653668785, 6071.514278857592, 6097.939020609914, 6113.57204995646, 6152.107944347955, 6198.349173336915, 5840.2991641003355, 5864.208331875142, 5909.2908850938165, 5916.142159386779, 6000.279966403885, 5847.590668653153, 5858.681796595903, 5905.970470147622, 5931.093764055668, 5939.851503712442, 5744.913826292693, 5811.157382179645, 5813.82558523245, 5825.854353641193, 5854.268216472941, 5700.942990570207, 5905.025670764276, 5919.23050003514, 5936.387989284701, 5965.492933100735, 5757.5393968481585, 5769.29805707309, 5851.327097383855, 5858.414158584107, 5862.648241105548], "value": 4371.848839166177, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.5090715581294, 750.0661676213113, 764.1059959846975, 794.5034353529045, 795.8090058385989, 15159.545213643582, 15242.618934526643, 15677.608059798511, 16233.91883040586, 16274.186290685477, 14423.350949207284, 14437.494687685934, 14528.200948947804, 14529.782053269182, 14576.271186440688, 661.1471202149222, 803.080472858578, 808.8746244332137, 812.8374325134968, 812.9634166462523, 778.3889646627399, 796.4424902568196, 801.5110782422746, 802.2899733735657, 806.9233422824823, 836.3392919593514, 839.911809260028, 844.2486187293283, 844.8986121665408, 845.9154084591522, 826.5247482697444, 829.5396055189367, 831.0484495252962, 831.4844796226317, 834.4450940124809, 606.4875180472537, 608.6409018678956, 609.832296118571, 610.8900397928371, 611.8776244751023, 15015.774763378558, 15045.0, 15144.621384465476, 15146.697066058618, 15155.545333640008, 13394.598162055154, 13470.057096003284, 14119.0, 14531.78202326966, 14562.0, 11509.366984815832, 11522.711932201679, 11524.308541487537, 11545.30728156305, 11881.881181188164, 3761.492198553188, 3867.9226415471812, 3911.3741801311653, 3994.6804255659767, 4015.9196816063513, 72726.0, 73489.63255183744, 73834.63082684606, 74265.0, 74404.0, 9671.274654400948, 10072.748181295527, 10774.24580279373, 11089.168312376443, 11266.267692600119, 20847.478813029797, 20850.89574552148, 20853.582928341348, 20857.374278771662, 20864.687029694567, 8212.46618969765, 8287.585620718939, 8298.668053277801, 8592.140785921358, 8613.61238744258, 4541.545845415432, 4656.138614356287, 4757.690750101232, 4807.230843065163, 4868.756562171877, 3346.4143774839304, 3417.043227896193, 3426.4860270959057, 3430.468277417004, 3450.46517789743, 578.2136294639287, 583.2738240890119, 588.9676067816312, 589.4665327878276, 590.9793157239562, 597.3220394851787, 597.9551533634994, 673.4881490067486, 681.9795406137824, 718.964051797408, 9475.052494750607, 10010.14913732341, 10103.7474063149, 10209.9489502552, 10306.845397319046, 669.5112567825514, 714.653393104344, 715.2168375628678, 752.9849403011909, 764.8699721047435, 4579.793909274091, 4983.8006479741125, 4988.326575912278, 5063.924041139386, 5068.391792984866, 115250.4237478824, 117051.0, 117238.0, 117295.0, 118282.0, 100455.99544004613, 100709.49645251727, 101337.0, 103229.0, 103658.48170759098, 57367.0, 58272.4172758267, 71927.64036179785, 89241.0, 92558.99999999865, 9373.953130234579, 9523.380980236263, 9597.136257736836, 9622.226324902393, 9644.180244679, 50649.0, 51023.48976510336, 51132.0, 51181.0, 51930.74034629803, 51110.23334649909, 67229.0, 71651.28348716446, 72754.27245727475, 76468.23531764612, 12499.500019999097, 12804.871951280367, 12811.87188128144, 12932.288724120264, 13246.139000964906, 14469.710605788036, 14893.627659308604, 15484.5354639361, 15552.688946221238, 15560.0, 13893.30533473302, 13936.79094813599, 14301.713965720835, 14302.427902884185, 14613.780793287897, 14021.158730476203, 14207.502737404142, 14396.928015359856, 14409.495667651581, 14503.492377766728, 12526.185797923106, 12827.166234195121, 13053.477860885458, 13114.409851556893, 13234.536791212262, 10514.631987880388, 10544.26190166681, 10684.89315106839, 10962.671119866416, 10977.341359518136, 10450.634227801991, 11133.498992545517, 11185.832212516982, 11817.409129543661, 11961.581344652895], "value": 7449.41797169245, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 105.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0, 109.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 150.0, 177.0, 126.0, 151.0, 160.0, 126.0, 181.0, 128.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 163.0, 164.0, 169.0, 164.0, 163.0, 161.0, 160.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 170.0, 84.0, 75.0, 75.0, 76.0, 167.0, 77.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 145.0, 85.0, 91.0, 86.0, 140.0, 84.0, 85.0, 140.0], "value": 102.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 146.0, 148.0, 146.0, 147.0, 147.0, 147.0, 148.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 56.0, 54.0, 55.0, 56.0, 54.0, 54.0, 53.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 64.0, 62.0, 64.0, 63.0, 63.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 82.0, 85.0, 81.0, 81.0, 86.0, 86.0, 109.0, 80.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 143.0, 122.0, 135.0, 121.0, 143.0, 124.0, 130.0, 127.0, 127.0], "value": 130.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 164.0, 159.0, 161.0, 165.0, 159.0, 159.0, 159.0, 159.0], "value": 161.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 66.0, 64.0, 64.0, 64.0, 63.0, 64.0, 62.0, 62.0], "value": 63.7, "unit": "score"}]}]} 09:43:52 INFO - Return code: 0 09:43:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:52 ERROR - # TBPL SUCCESS # 09:43:52 INFO - Running post-action listener: _resource_record_post_action 09:43:52 INFO - ##### 09:43:52 INFO - ##### Finished run-tests step (success) 09:43:52 INFO - ##### 09:43:52 INFO - Running post-run listener: _resource_record_post_run 09:43:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549060608; Read time: 12; Write time: 440892 09:43:52 INFO - TinderboxPrint: CPU usage
13.5% 09:43:52 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:43:52 INFO - TinderboxPrint: I/O write bytes / time
549,060,608 / 440,892 09:43:52 INFO - TinderboxPrint: CPU idle
8,224.5 (86.5%) 09:43:52 INFO - TinderboxPrint: CPU user
1,224.4 (12.9%) 09:43:52 INFO - TinderboxPrint: Swap in / out
0 / 0 09:43:52 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 255533056; Read time: 0; Write time: 227064 09:43:52 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293326848; Read time: 12; Write time: 213804 09:43:52 INFO - Running post-run listener: _upload_blobber_files 09:43:52 INFO - Blob upload gear active. 09:43:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:52 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 09:43:52 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'] 09:43:52 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 09:43:53 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:43:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:43:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:53 INFO - (blobuploader) - INFO - Done attempting. 09:43:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:43:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:43:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:57 INFO - (blobuploader) - INFO - Done attempting. 09:43:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:43:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:43:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:58 INFO - (blobuploader) - INFO - Done attempting. 09:43:58 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:58 INFO - Return code: 0 09:43:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f05621933184750ce50b339838b65afa30ac55abf81f374b0c3aa18e5d03403e6496cb43ea4d29a5406d53201aa9d67d6b980320ab62fc318310f37833eba62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727a38a1fc549c38539156b629f40473653f165142c9ff994cd2f2488ca5dc0757f8217c077f213a32d66168920070b6fd2e799274247610bedff1a47bcfef09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/695c776e79b08c6ca3e7c415af31ef21713959e8cbec3b45e51662af6ca621fa69bc30d0c4214c5db64b8e2dfd0ac4f8c82ca99b14d4c2f777d21f9efa7fd751"} 09:43:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:58 INFO - Contents: 09:43:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0f05621933184750ce50b339838b65afa30ac55abf81f374b0c3aa18e5d03403e6496cb43ea4d29a5406d53201aa9d67d6b980320ab62fc318310f37833eba62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727a38a1fc549c38539156b629f40473653f165142c9ff994cd2f2488ca5dc0757f8217c077f213a32d66168920070b6fd2e799274247610bedff1a47bcfef09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/695c776e79b08c6ca3e7c415af31ef21713959e8cbec3b45e51662af6ca621fa69bc30d0c4214c5db64b8e2dfd0ac4f8c82ca99b14d4c2f777d21f9efa7fd751"} 09:43:58 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:58 INFO - Copying logs to upload dir... 09:43:58 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.430371 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-06-17 09:43:58.548255) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:43:58.551985) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699 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/0f05621933184750ce50b339838b65afa30ac55abf81f374b0c3aa18e5d03403e6496cb43ea4d29a5406d53201aa9d67d6b980320ab62fc318310f37833eba62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727a38a1fc549c38539156b629f40473653f165142c9ff994cd2f2488ca5dc0757f8217c077f213a32d66168920070b6fd2e799274247610bedff1a47bcfef09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/695c776e79b08c6ca3e7c415af31ef21713959e8cbec3b45e51662af6ca621fa69bc30d0c4214c5db64b8e2dfd0ac4f8c82ca99b14d4c2f777d21f9efa7fd751"} build_url:https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.012002 build_url: 'https://queue.taskcluster.net/v1/task/MNb2vAcXT4CR_lx-neIZOw/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/0f05621933184750ce50b339838b65afa30ac55abf81f374b0c3aa18e5d03403e6496cb43ea4d29a5406d53201aa9d67d6b980320ab62fc318310f37833eba62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/727a38a1fc549c38539156b629f40473653f165142c9ff994cd2f2488ca5dc0757f8217c077f213a32d66168920070b6fd2e799274247610bedff1a47bcfef09", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/695c776e79b08c6ca3e7c415af31ef21713959e8cbec3b45e51662af6ca621fa69bc30d0c4214c5db64b8e2dfd0ac4f8c82ca99b14d4c2f777d21f9efa7fd751"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-17 09:43:58.581506) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:43:58.581863) ========= 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=a0d2d2de893abaa8702a9954000001a7-1466180603.508468-2074924699 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004689 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-17 09:43:58.667624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:43:58.667954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-17 09:43:58.668297) ========= ========= Total master_lag: 0.18 =========