builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1465247446.85 results: success (0) buildid: 20160606113026 builduid: 72080a92fcb041e48af3e5333fb1b521 revision: 8a363789d659493f11efc0a4621b107b10e3fef3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:46.847887) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:46.848560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:46.848869) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:46.865059) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:46.865343) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 14:10:47-- 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% 46.5M=0s 2016-06-06 14:10:47 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158562 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.093283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.093605) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014810 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.125039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.125435) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a363789d659493f11efc0a4621b107b10e3fef3 --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 8a363789d659493f11efc0a4621b107b10e3fef3 --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=516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 14:10:47,373 truncating revision to first 12 chars 2016-06-06 14:10:47,373 Setting DEBUG logging. 2016-06-06 14:10:47,373 attempt 1/10 2016-06-06 14:10:47,373 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a363789d659?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 14:10:47,681 unpacking tar archive at: fx-team-8a363789d659/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.756411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.759774) ========= script_repo_revision: 8a363789d659493f11efc0a4621b107b10e3fef3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.760222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.760502) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 14:10:47.770508) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-06 14:10:47.770831) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:10:48 INFO - MultiFileLogger online at 20160606 14:10:48 in /builds/slave/test 14:10:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:10:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:10:48 INFO - {'append_to_log': False, 14:10:48 INFO - 'base_work_dir': '/builds/slave/test', 14:10:48 INFO - 'blob_upload_branch': 'Fx-Team', 14:10:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:10:48 INFO - 'branch': 'Fx-Team', 14:10:48 INFO - 'buildbot_json_path': 'buildprops.json', 14:10:48 INFO - 'config_files': ('talos/linux_config.py',), 14:10:48 INFO - 'default_actions': ('clobber', 14:10:48 INFO - 'read-buildbot-config', 14:10:48 INFO - 'download-and-extract', 14:10:48 INFO - 'populate-webroot', 14:10:48 INFO - 'create-virtualenv', 14:10:48 INFO - 'install', 14:10:48 INFO - 'run-tests'), 14:10:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:10:48 INFO - 'download_minidump_stackwalk': True, 14:10:48 INFO - 'download_symbols': 'ondemand', 14:10:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:10:48 INFO - 'tooltool.py': '/tools/tooltool.py', 14:10:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:10:48 INFO - '/tools/misc-python/virtualenv.py')}, 14:10:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:10:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:10:48 INFO - 'installer_path': 'installer.exe', 14:10:48 INFO - 'log_level': 'info', 14:10:48 INFO - 'log_name': 'talos', 14:10:48 INFO - 'log_to_console': True, 14:10:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:10:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:10:48 INFO - 'opt_config_files': (), 14:10:48 INFO - 'pip_index': False, 14:10:48 INFO - 'sps_profile': False, 14:10:48 INFO - 'sps_profile_interval': 0, 14:10:48 INFO - 'suite': 'dromaeojs', 14:10:48 INFO - 'system_bits': '32', 14:10:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:10:48 INFO - 'title': 'talos-linux64-ix-061', 14:10:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:10:48 INFO - 'use_talos_json': True, 14:10:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:10:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:10:48 INFO - 'work_dir': 'build'} 14:10:48 INFO - ##### 14:10:48 INFO - ##### Running clobber step. 14:10:48 INFO - ##### 14:10:48 INFO - Running pre-action listener: _resource_record_pre_action 14:10:48 INFO - Running main action method: clobber 14:10:48 INFO - rmtree: /builds/slave/test/build 14:10:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:10:48 INFO - Running post-action listener: _resource_record_post_action 14:10:48 INFO - ##### 14:10:48 INFO - ##### Finished clobber step (success) 14:10:48 INFO - ##### 14:10:48 INFO - ##### 14:10:48 INFO - ##### Running read-buildbot-config step. 14:10:48 INFO - ##### 14:10:48 INFO - Running pre-action listener: _resource_record_pre_action 14:10:48 INFO - Running main action method: read_buildbot_config 14:10:48 INFO - Using buildbot properties: 14:10:48 INFO - { 14:10:48 INFO - "project": "", 14:10:48 INFO - "product": "firefox", 14:10:48 INFO - "script_repo_revision": "production", 14:10:48 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:10:48 INFO - "repository": "", 14:10:48 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 14:10:48 INFO - "buildid": "20160606113026", 14:10:48 INFO - "pgo_build": "True", 14:10:48 INFO - "basedir": "/builds/slave/test", 14:10:48 INFO - "buildnumber": 162, 14:10:48 INFO - "slavename": "talos-linux64-ix-061", 14:10:48 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:10:48 INFO - "platform": "ubuntu64_hw", 14:10:48 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 14:10:48 INFO - "branch": "fx-team", 14:10:48 INFO - "repo_path": "integration/fx-team", 14:10:48 INFO - "revision": "8a363789d659493f11efc0a4621b107b10e3fef3", 14:10:48 INFO - "stage_platform": "linux64-pgo", 14:10:48 INFO - "builduid": "72080a92fcb041e48af3e5333fb1b521", 14:10:48 INFO - "slavebuilddir": "test" 14:10:48 INFO - } 14:10:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:10:48 INFO - Running post-action listener: _resource_record_post_action 14:10:48 INFO - ##### 14:10:48 INFO - ##### Finished read-buildbot-config step (success) 14:10:48 INFO - ##### 14:10:48 INFO - ##### 14:10:48 INFO - ##### Running download-and-extract step. 14:10:48 INFO - ##### 14:10:48 INFO - Running pre-action listener: _resource_record_pre_action 14:10:48 INFO - Running main action method: download_and_extract 14:10:48 INFO - mkdir: /builds/slave/test/build/tests 14:10: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')]} 14:10:48 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:10:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:10:49 INFO - Downloaded 1361 bytes. 14:10:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:10:49 INFO - Using the following test package requirements: 14:10:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:10:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:10:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'jsshell-linux-x86_64.zip'], 14:10:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:10:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:10:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:10:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:10:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:10:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:10:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:10:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:10:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:49 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:50 INFO - Downloaded 24443829 bytes. 14:10:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:51 INFO - Return code: 0 14:10:51 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:51 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:10:52 INFO - Downloaded 24443829 bytes. 14:10:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:10:54 INFO - Return code: 0 14:10:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:54 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:10:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:10:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:10:55 INFO - Downloaded 10833369 bytes. 14:10:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:10:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:10:55 INFO - Return code: 0 14:10: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')]} 14:10:55 INFO - https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:10:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:10:59 INFO - Downloaded 59193663 bytes. 14:10:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:10:59 INFO - mkdir: /builds/slave/test/properties 14:10:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:59 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:59 INFO - Contents: 14:10:59 INFO - build_url:https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:11:03 INFO - Running post-action listener: _resource_record_post_action 14:11:03 INFO - Running post-action listener: set_extra_try_arguments 14:11:03 INFO - ##### 14:11:03 INFO - ##### Finished download-and-extract step (success) 14:11:03 INFO - ##### 14:11:03 INFO - ##### 14:11:03 INFO - ##### Running populate-webroot step. 14:11:03 INFO - ##### 14:11:03 INFO - Running pre-action listener: _resource_record_pre_action 14:11:03 INFO - Running main action method: populate_webroot 14:11:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:11:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:11:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:11:03 INFO - '--tppagecycles', 14:11:03 INFO - '7'], 14:11:03 INFO - 'tests': ['tsvgm']}}, 14:11:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:11:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:11:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:11:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:11:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:11:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['damp', 'tps']}, 14:11:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'tests': ['damp', 'tps']}, 14:11:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['dromaeo_dom']}, 14:11:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:11:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['a11yr', 14:11:03 INFO - 'ts_paint', 14:11:03 INFO - 'tpaint', 14:11:03 INFO - 'sessionrestore', 14:11:03 INFO - 'sessionrestore_no_auto_restore', 14:11:03 INFO - 'tabpaint']}, 14:11:03 INFO - 'other-e10s': {'tests': ['a11yr', 14:11:03 INFO - 'ts_paint', 14:11:03 INFO - 'tpaint', 14:11:03 INFO - 'sessionrestore', 14:11:03 INFO - 'sessionrestore_no_auto_restore', 14:11:03 INFO - 'tabpaint']}, 14:11:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:11:03 INFO - 'ts_paint', 14:11:03 INFO - 'tpaint', 14:11:03 INFO - 'sessionrestore', 14:11:03 INFO - 'sessionrestore_no_auto_restore', 14:11:03 INFO - 'tabpaint']}, 14:11:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:11:03 INFO - 'ts_paint', 14:11:03 INFO - 'tpaint', 14:11:03 INFO - 'sessionrestore', 14:11:03 INFO - 'sessionrestore_no_auto_restore', 14:11:03 INFO - 'tabpaint']}, 14:11:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['a11yr', 14:11:03 INFO - 'ts_paint', 14:11:03 INFO - 'tpaint', 14:11:03 INFO - 'sessionrestore', 14:11:03 INFO - 'sessionrestore_no_auto_restore', 14:11:03 INFO - 'tabpaint']}, 14:11:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['a11yr', 14:11:03 INFO - 'ts_paint', 14:11:03 INFO - 'tpaint', 14:11:03 INFO - 'sessionrestore', 14:11:03 INFO - 'sessionrestore_no_auto_restore', 14:11:03 INFO - 'tabpaint']}, 14:11:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['tsvgx', 14:11:03 INFO - 'tsvgr_opacity', 14:11:03 INFO - 'tart', 14:11:03 INFO - 'tscrollx', 14:11:03 INFO - 'cart']}, 14:11:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:11:03 INFO - 'tsvgr_opacity', 14:11:03 INFO - 'tart', 14:11:03 INFO - 'tscrollx', 14:11:03 INFO - 'cart']}, 14:11:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'talos_options': ['--disable-e10s'], 14:11:03 INFO - 'tests': ['tp5o']}, 14:11:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'tests': ['tp5o']}, 14:11:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'talos_options': ['--disable-e10s', 14:11:03 INFO - '--xperf_path', 14:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:03 INFO - 'tests': ['tp5n']}, 14:11:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:11:03 INFO - 'talos_options': ['--xperf_path', 14:11:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:11:03 INFO - 'tests': ['tp5n']}}, 14:11:03 INFO - 'talos.zip': {'path': '', 14:11:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:11:03 INFO - Running post-action listener: _resource_record_post_action 14:11:03 INFO - ##### 14:11:03 INFO - ##### Finished populate-webroot step (success) 14:11:03 INFO - ##### 14:11:03 INFO - ##### 14:11:03 INFO - ##### Running create-virtualenv step. 14:11:03 INFO - ##### 14:11:03 INFO - Running pre-action listener: _resource_record_pre_action 14:11:03 INFO - Running main action method: create_virtualenv 14:11:03 INFO - Creating virtualenv /builds/slave/test/build/venv 14:11:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:11:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:11:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:11:03 INFO - Using real prefix '/usr' 14:11:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:11:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:11:05 INFO - Installing pip.................done. 14:11:05 INFO - Return code: 0 14:11:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:05 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:11:05 INFO - Using env: {'DISPLAY': ':0', 14:11:05 INFO - 'HOME': '/home/cltbld', 14:11:05 INFO - 'LANG': 'en_US.UTF-8', 14:11:05 INFO - 'LANGUAGE': 'en_US:en', 14:11:05 INFO - 'LOGNAME': 'cltbld', 14:11:05 INFO - 'MAIL': '/var/mail/cltbld', 14:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:05 INFO - 'MOZ_NO_REMOTE': '1', 14:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:05 INFO - 'NO_EM_RESTART': '1', 14:11:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:05 INFO - 'PWD': '/builds/slave/test', 14:11:05 INFO - 'SHELL': '/bin/bash', 14:11:05 INFO - 'SHLVL': '1', 14:11:05 INFO - 'TERM': 'linux', 14:11:05 INFO - 'TMOUT': '86400', 14:11:05 INFO - 'USER': 'cltbld', 14:11:05 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:05 INFO - '_': '/tools/buildbot/bin/python'} 14:11:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:11:05 INFO - Cleaning up... 14:11:06 INFO - Return code: 0 14:11:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:06 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:11:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:11:06 INFO - Using env: {'DISPLAY': ':0', 14:11:06 INFO - 'HOME': '/home/cltbld', 14:11:06 INFO - 'LANG': 'en_US.UTF-8', 14:11:06 INFO - 'LANGUAGE': 'en_US:en', 14:11:06 INFO - 'LOGNAME': 'cltbld', 14:11:06 INFO - 'MAIL': '/var/mail/cltbld', 14:11:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:06 INFO - 'MOZ_NO_REMOTE': '1', 14:11:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:06 INFO - 'NO_EM_RESTART': '1', 14:11:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:06 INFO - 'PWD': '/builds/slave/test', 14:11:06 INFO - 'SHELL': '/bin/bash', 14:11:06 INFO - 'SHLVL': '1', 14:11:06 INFO - 'TERM': 'linux', 14:11:06 INFO - 'TMOUT': '86400', 14:11:06 INFO - 'USER': 'cltbld', 14:11:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:06 INFO - '_': '/tools/buildbot/bin/python'} 14:11:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:06 INFO - Downloading/unpacking psutil>=3.1.1 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:08 INFO - Installing collected packages: psutil 14:11:08 INFO - Running setup.py install for psutil 14:11:08 INFO - building 'psutil._psutil_linux' extension 14:11:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:11:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:11:08 INFO - building 'psutil._psutil_posix' extension 14:11:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:11:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:11:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:11:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:11:08 INFO - Successfully installed psutil 14:11:08 INFO - Cleaning up... 14:11:08 INFO - Return code: 0 14:11:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:08 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:11:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:11:08 INFO - Using env: {'DISPLAY': ':0', 14:11:08 INFO - 'HOME': '/home/cltbld', 14:11:08 INFO - 'LANG': 'en_US.UTF-8', 14:11:08 INFO - 'LANGUAGE': 'en_US:en', 14:11:08 INFO - 'LOGNAME': 'cltbld', 14:11:08 INFO - 'MAIL': '/var/mail/cltbld', 14:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:08 INFO - 'MOZ_NO_REMOTE': '1', 14:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:08 INFO - 'NO_EM_RESTART': '1', 14:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:08 INFO - 'PWD': '/builds/slave/test', 14:11:08 INFO - 'SHELL': '/bin/bash', 14:11:08 INFO - 'SHLVL': '1', 14:11:08 INFO - 'TERM': 'linux', 14:11:08 INFO - 'TMOUT': '86400', 14:11:08 INFO - 'USER': 'cltbld', 14:11:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:08 INFO - '_': '/tools/buildbot/bin/python'} 14:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:11:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:11:10 INFO - Installing collected packages: mozsystemmonitor 14:11:10 INFO - Running setup.py install for mozsystemmonitor 14:11:11 INFO - Successfully installed mozsystemmonitor 14:11:11 INFO - Cleaning up... 14:11:11 INFO - Return code: 0 14:11:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:11 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:11:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:11:11 INFO - Using env: {'DISPLAY': ':0', 14:11:11 INFO - 'HOME': '/home/cltbld', 14:11:11 INFO - 'LANG': 'en_US.UTF-8', 14:11:11 INFO - 'LANGUAGE': 'en_US:en', 14:11:11 INFO - 'LOGNAME': 'cltbld', 14:11:11 INFO - 'MAIL': '/var/mail/cltbld', 14:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:11 INFO - 'MOZ_NO_REMOTE': '1', 14:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:11 INFO - 'NO_EM_RESTART': '1', 14:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:11 INFO - 'PWD': '/builds/slave/test', 14:11:11 INFO - 'SHELL': '/bin/bash', 14:11:11 INFO - 'SHLVL': '1', 14:11:11 INFO - 'TERM': 'linux', 14:11:11 INFO - 'TMOUT': '86400', 14:11:11 INFO - 'USER': 'cltbld', 14:11:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:11 INFO - '_': '/tools/buildbot/bin/python'} 14:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:11 INFO - Downloading/unpacking jsonschema==2.5.1 14:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:11:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:11:13 INFO - warning: no files found matching '*.txt' 14:11:13 INFO - no previously-included directories found matching 'build' 14:11:13 INFO - no previously-included directories found matching 'dist' 14:11:13 INFO - no previously-included directories found matching '.git*' 14:11:13 INFO - Installing collected packages: jsonschema, functools32 14:11:13 INFO - Running setup.py install for functools32 14:11:13 INFO - warning: no files found matching '*.txt' 14:11:13 INFO - no previously-included directories found matching 'build' 14:11:13 INFO - no previously-included directories found matching 'dist' 14:11:13 INFO - no previously-included directories found matching '.git*' 14:11:13 INFO - Successfully installed jsonschema functools32 14:11:13 INFO - Cleaning up... 14:11:13 INFO - Return code: 0 14:11:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:13 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:11:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:11:13 INFO - Using env: {'DISPLAY': ':0', 14:11:13 INFO - 'HOME': '/home/cltbld', 14:11:13 INFO - 'LANG': 'en_US.UTF-8', 14:11:13 INFO - 'LANGUAGE': 'en_US:en', 14:11:13 INFO - 'LOGNAME': 'cltbld', 14:11:13 INFO - 'MAIL': '/var/mail/cltbld', 14:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:13 INFO - 'MOZ_NO_REMOTE': '1', 14:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:13 INFO - 'NO_EM_RESTART': '1', 14:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:13 INFO - 'PWD': '/builds/slave/test', 14:11:13 INFO - 'SHELL': '/bin/bash', 14:11:13 INFO - 'SHLVL': '1', 14:11:13 INFO - 'TERM': 'linux', 14:11:13 INFO - 'TMOUT': '86400', 14:11:13 INFO - 'USER': 'cltbld', 14:11:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:13 INFO - '_': '/tools/buildbot/bin/python'} 14:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:11:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:11:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:16 INFO - Downloading docopt-0.6.1.tar.gz 14:11:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:11:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:11:16 INFO - Running setup.py install for blobuploader 14:11:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:11:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:11:16 INFO - Running setup.py install for requests 14:11:17 INFO - Running setup.py install for docopt 14:11:17 INFO - Successfully installed blobuploader requests docopt 14:11:17 INFO - Cleaning up... 14:11:17 INFO - Return code: 0 14:11:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:17 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:17 INFO - Using env: {'DISPLAY': ':0', 14:11:17 INFO - 'HOME': '/home/cltbld', 14:11:17 INFO - 'LANG': 'en_US.UTF-8', 14:11:17 INFO - 'LANGUAGE': 'en_US:en', 14:11:17 INFO - 'LOGNAME': 'cltbld', 14:11:17 INFO - 'MAIL': '/var/mail/cltbld', 14:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:17 INFO - 'MOZ_NO_REMOTE': '1', 14:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:17 INFO - 'NO_EM_RESTART': '1', 14:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:17 INFO - 'PWD': '/builds/slave/test', 14:11:17 INFO - 'SHELL': '/bin/bash', 14:11:17 INFO - 'SHLVL': '1', 14:11:17 INFO - 'TERM': 'linux', 14:11:17 INFO - 'TMOUT': '86400', 14:11:17 INFO - 'USER': 'cltbld', 14:11:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:17 INFO - '_': '/tools/buildbot/bin/python'} 14:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:17 INFO - Running setup.py (path:/tmp/pip-vpFYYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:17 INFO - Running setup.py (path:/tmp/pip-XqkKow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:17 INFO - Running setup.py (path:/tmp/pip-5tJuXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:17 INFO - Running setup.py (path:/tmp/pip-u9Tw_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:17 INFO - Running setup.py (path:/tmp/pip-tf6XD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:17 INFO - Running setup.py (path:/tmp/pip-d9kLid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:17 INFO - Running setup.py (path:/tmp/pip-0AKaPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:17 INFO - Running setup.py (path:/tmp/pip-TGVQIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:18 INFO - Running setup.py (path:/tmp/pip-j_Az4G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:18 INFO - Running setup.py (path:/tmp/pip-SfGbWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:18 INFO - Running setup.py (path:/tmp/pip-0akCk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:18 INFO - Running setup.py (path:/tmp/pip-eLV1q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:18 INFO - Running setup.py (path:/tmp/pip-pwf8PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:18 INFO - Running setup.py (path:/tmp/pip-jKumSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:18 INFO - Running setup.py (path:/tmp/pip-p4zAD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:18 INFO - Running setup.py (path:/tmp/pip-LerPCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:18 INFO - Running setup.py (path:/tmp/pip-Q4pz6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:11:18 INFO - Running setup.py install for manifestparser 14:11:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:11:18 INFO - Running setup.py install for mozcrash 14:11:18 INFO - Running setup.py install for mozdebug 14:11:18 INFO - Running setup.py install for mozdevice 14:11:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for mozfile 14:11:19 INFO - Running setup.py install for mozhttpd 14:11:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for mozinfo 14:11:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for mozInstall 14:11:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for mozleak 14:11:19 INFO - Running setup.py install for mozlog 14:11:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for moznetwork 14:11:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:11:19 INFO - Running setup.py install for mozprocess 14:11:19 INFO - Running setup.py install for mozprofile 14:11:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozrunner 14:11:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Running setup.py install for mozscreenshot 14:11:20 INFO - Running setup.py install for moztest 14:11:20 INFO - Running setup.py install for mozversion 14:11:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:11:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:11:20 INFO - Cleaning up... 14:11:20 INFO - Return code: 0 14:11:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:20 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:20 INFO - Using env: {'DISPLAY': ':0', 14:11:20 INFO - 'HOME': '/home/cltbld', 14:11:20 INFO - 'LANG': 'en_US.UTF-8', 14:11:20 INFO - 'LANGUAGE': 'en_US:en', 14:11:20 INFO - 'LOGNAME': 'cltbld', 14:11:20 INFO - 'MAIL': '/var/mail/cltbld', 14:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:20 INFO - 'MOZ_NO_REMOTE': '1', 14:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:20 INFO - 'NO_EM_RESTART': '1', 14:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:20 INFO - 'PWD': '/builds/slave/test', 14:11:20 INFO - 'SHELL': '/bin/bash', 14:11:20 INFO - 'SHLVL': '1', 14:11:20 INFO - 'TERM': 'linux', 14:11:20 INFO - 'TMOUT': '86400', 14:11:20 INFO - 'USER': 'cltbld', 14:11:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:20 INFO - '_': '/tools/buildbot/bin/python'} 14:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:11:20 INFO - Running setup.py (path:/tmp/pip-3hQGpB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:11:20 INFO - Running setup.py (path:/tmp/pip-4y5YZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:11:20 INFO - Running setup.py (path:/tmp/pip-3vAhyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:11:20 INFO - Running setup.py (path:/tmp/pip-GDbQkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:11:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:11:20 INFO - Running setup.py (path:/tmp/pip-sGmF0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:11:21 INFO - Running setup.py (path:/tmp/pip-AaWI6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:11:21 INFO - Running setup.py (path:/tmp/pip-3S6B58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:11:21 INFO - Running setup.py (path:/tmp/pip-2EQGfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:11:21 INFO - Running setup.py (path:/tmp/pip-1r1vkM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:11:21 INFO - Running setup.py (path:/tmp/pip-2RaN9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:11:21 INFO - Running setup.py (path:/tmp/pip-Nx4JK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:11:21 INFO - Running setup.py (path:/tmp/pip-ck196z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:11:21 INFO - Running setup.py (path:/tmp/pip-TrVCYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:11:21 INFO - Running setup.py (path:/tmp/pip-er_443-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:21 INFO - Running setup.py (path:/tmp/pip-9Qr9Sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:11:21 INFO - Running setup.py (path:/tmp/pip-6DsW_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:11:21 INFO - Running setup.py (path:/tmp/pip-Q3770p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:11:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:23 INFO - Downloading blessings-1.6.tar.gz 14:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:11:23 INFO - Installing collected packages: blessings 14:11:23 INFO - Running setup.py install for blessings 14:11:24 INFO - Successfully installed blessings 14:11:24 INFO - Cleaning up... 14:11:24 INFO - Return code: 0 14:11:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:11:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:24 INFO - Reading from file tmpfile_stdout 14:11:24 INFO - Current package versions: 14:11:24 INFO - argparse == 1.2.1 14:11:24 INFO - blessings == 1.6 14:11:24 INFO - blobuploader == 1.2.4 14:11:24 INFO - docopt == 0.6.1 14:11:24 INFO - functools32 == 3.2.3-2 14:11:24 INFO - jsonschema == 2.5.1 14:11:24 INFO - manifestparser == 1.1 14:11:24 INFO - mozInstall == 1.12 14:11:24 INFO - mozcrash == 0.17 14:11:24 INFO - mozdebug == 0.1 14:11:24 INFO - mozdevice == 0.48 14:11:24 INFO - mozfile == 1.2 14:11:24 INFO - mozhttpd == 0.7 14:11:24 INFO - mozinfo == 0.9 14:11:24 INFO - mozleak == 0.1 14:11:24 INFO - mozlog == 3.2 14:11:24 INFO - moznetwork == 0.27 14:11:24 INFO - mozprocess == 0.22 14:11:24 INFO - mozprofile == 0.28 14:11:24 INFO - mozrunner == 6.11 14:11:24 INFO - mozscreenshot == 0.1 14:11:24 INFO - mozsystemmonitor == 0.3 14:11:24 INFO - moztest == 0.7 14:11:24 INFO - mozversion == 1.4 14:11:24 INFO - psutil == 3.1.1 14:11:24 INFO - requests == 1.2.3 14:11:24 INFO - wsgiref == 0.1.2 14:11:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:11:24 INFO - Using env: {'DISPLAY': ':0', 14:11:24 INFO - 'HOME': '/home/cltbld', 14:11:24 INFO - 'LANG': 'en_US.UTF-8', 14:11:24 INFO - 'LANGUAGE': 'en_US:en', 14:11:24 INFO - 'LOGNAME': 'cltbld', 14:11:24 INFO - 'MAIL': '/var/mail/cltbld', 14:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:24 INFO - 'MOZ_NO_REMOTE': '1', 14:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:24 INFO - 'NO_EM_RESTART': '1', 14:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:24 INFO - 'PWD': '/builds/slave/test', 14:11:24 INFO - 'SHELL': '/bin/bash', 14:11:24 INFO - 'SHLVL': '1', 14:11:24 INFO - 'TERM': 'linux', 14:11:24 INFO - 'TMOUT': '86400', 14:11:24 INFO - 'USER': 'cltbld', 14:11:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:24 INFO - '_': '/tools/buildbot/bin/python'} 14:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:11:24 INFO - Cleaning up... 14:11:24 INFO - Return code: 0 14:11:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:11:24 INFO - Using env: {'DISPLAY': ':0', 14:11:24 INFO - 'HOME': '/home/cltbld', 14:11:24 INFO - 'LANG': 'en_US.UTF-8', 14:11:24 INFO - 'LANGUAGE': 'en_US:en', 14:11:24 INFO - 'LOGNAME': 'cltbld', 14:11:24 INFO - 'MAIL': '/var/mail/cltbld', 14:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:24 INFO - 'MOZ_NO_REMOTE': '1', 14:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:24 INFO - 'NO_EM_RESTART': '1', 14:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:24 INFO - 'PWD': '/builds/slave/test', 14:11:24 INFO - 'SHELL': '/bin/bash', 14:11:24 INFO - 'SHLVL': '1', 14:11:24 INFO - 'TERM': 'linux', 14:11:24 INFO - 'TMOUT': '86400', 14:11:24 INFO - 'USER': 'cltbld', 14:11:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:24 INFO - '_': '/tools/buildbot/bin/python'} 14:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:11:24 INFO - Cleaning up... 14:11:24 INFO - Return code: 0 14:11:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:11:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:11:24 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 0x7f3552cccf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1be38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1caff60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:11:24 INFO - Using env: {'DISPLAY': ':0', 14:11:24 INFO - 'HOME': '/home/cltbld', 14:11:24 INFO - 'LANG': 'en_US.UTF-8', 14:11:24 INFO - 'LANGUAGE': 'en_US:en', 14:11:24 INFO - 'LOGNAME': 'cltbld', 14:11:24 INFO - 'MAIL': '/var/mail/cltbld', 14:11:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:24 INFO - 'MOZ_NO_REMOTE': '1', 14:11:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:24 INFO - 'NO_EM_RESTART': '1', 14:11:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:24 INFO - 'PWD': '/builds/slave/test', 14:11:24 INFO - 'SHELL': '/bin/bash', 14:11:24 INFO - 'SHLVL': '1', 14:11:24 INFO - 'TERM': 'linux', 14:11:24 INFO - 'TMOUT': '86400', 14:11:24 INFO - 'USER': 'cltbld', 14:11:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:24 INFO - '_': '/tools/buildbot/bin/python'} 14:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:11:24 INFO - Downloading/unpacking flake8 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:11:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:11:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:11:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:27 INFO - no previously-included directories found matching 'docs/_build' 14:11:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:11:27 INFO - Running setup.py install for pep8 14:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:11:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:11:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:11:28 INFO - no previously-included directories found matching 'docs/_build' 14:11:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:11:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:11:28 INFO - Cleaning up... 14:11:28 INFO - Return code: 0 14:11:28 INFO - Running post-action listener: _resource_record_post_action 14:11:28 INFO - Running post-action listener: _start_resource_monitoring 14:11:29 INFO - Starting resource monitoring. 14:11:29 INFO - ##### 14:11:29 INFO - ##### Finished create-virtualenv step (success) 14:11:29 INFO - ##### 14:11:29 INFO - ##### 14:11:29 INFO - ##### Running install step. 14:11:29 INFO - ##### 14:11:29 INFO - Running pre-action listener: _resource_record_pre_action 14:11:29 INFO - Running main action method: install 14:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:11:29 INFO - Reading from file tmpfile_stdout 14:11:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:11:29 INFO - Reading from file tmpfile_stdout 14:11:29 INFO - Output received: 14:11:29 INFO - Usage: mozinstall [options] installer 14:11:29 INFO - Options: 14:11:29 INFO - -h, --help show this help message and exit 14:11:29 INFO - -d DEST, --destination=DEST 14:11:29 INFO - Directory to install application into. [default: 14:11:29 INFO - "/builds/slave/test"] 14:11:29 INFO - --app=APP Application being installed. [default: firefox] 14:11:29 INFO - mkdir: /builds/slave/test/build/application 14:11:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:11:46 INFO - Reading from file tmpfile_stdout 14:11:46 INFO - Output received: 14:11:46 INFO - /builds/slave/test/build/application/firefox/firefox 14:11:46 INFO - Running post-action listener: _resource_record_post_action 14:11:46 INFO - ##### 14:11:46 INFO - ##### Finished install step (success) 14:11:46 INFO - ##### 14:11:46 INFO - ##### 14:11:46 INFO - ##### Running run-tests step. 14:11:46 INFO - ##### 14:11:46 INFO - Running pre-action listener: _resource_record_pre_action 14:11:46 INFO - Running main action method: run_tests 14:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:11:46 INFO - Python 2.7.3 14:11:46 INFO - Return code: 0 14:11:46 INFO - grabbing minidump binary from tooltool 14:11:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:11:46 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 0x1d3f010>, '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 0x1d3fef0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d403a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:11:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:11:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:11:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:11:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:11:46 INFO - Return code: 0 14:11:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:11:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:11:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:11:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:11:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:11:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:11:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:11:47 INFO - Return code: 0 14:11:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:11:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:11:47 INFO - Using env: {'DISPLAY': ':0', 14:11:47 INFO - 'HOME': '/home/cltbld', 14:11:47 INFO - 'LANG': 'en_US.UTF-8', 14:11:47 INFO - 'LANGUAGE': 'en_US:en', 14:11:47 INFO - 'LOGNAME': 'cltbld', 14:11:47 INFO - 'MAIL': '/var/mail/cltbld', 14:11:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:11:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:11:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:11:47 INFO - 'MOZ_NO_REMOTE': '1', 14:11:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:11:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:11:47 INFO - 'NO_EM_RESTART': '1', 14:11:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:11:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:11:47 INFO - 'PWD': '/builds/slave/test', 14:11:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:11:47 INFO - 'SHELL': '/bin/bash', 14:11:47 INFO - 'SHLVL': '1', 14:11:47 INFO - 'TERM': 'linux', 14:11:47 INFO - 'TMOUT': '86400', 14:11:47 INFO - 'USER': 'cltbld', 14:11:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368', 14:11:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:11:47 INFO - '_': '/tools/buildbot/bin/python'} 14:11:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:11:47 INFO - mozversion application_buildid: 20160606113026 14:11:47 INFO - mozversion application_changeset: 8a363789d659493f11efc0a4621b107b10e3fef3 14:11:47 INFO - mozversion application_display_name: Nightly 14:11:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:11:47 INFO - mozversion application_name: Firefox 14:11:47 INFO - mozversion application_remotingname: firefox 14:11:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:11:47 INFO - mozversion application_vendor: Mozilla 14:11:47 INFO - mozversion application_version: 49.0a1 14:11:47 INFO - mozversion platform_buildid: 20160606113026 14:11:47 INFO - mozversion platform_changeset: 8a363789d659493f11efc0a4621b107b10e3fef3 14:11:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:11:47 INFO - mozversion platform_version: 49.0a1 14:11:47 INFO - using testdate: 1465247507 14:11:47 INFO - actual date: 1465247507 14:11:47 INFO - starting webserver on 'localhost:49157' 14:11:47 INFO - SUITE-START | Running 2 tests 14:11:47 INFO - TEST-START | dromaeo_css 14:11:47 INFO - operating with platform_type : linux_ 14:11:47 INFO - Initialising browser for dromaeo_css test... 14:11:47 INFO - TEST-INFO | started process 11279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv0w6wl/profile http://localhost:49157/getInfo.html) 14:11:52 INFO - PROCESS | 11279 | __metrics Screen width/height:1600/1200 14:11:52 INFO - PROCESS | 11279 | colorDepth:24 14:11:52 INFO - PROCESS | 11279 | Browser inner width/height: 1024/697 14:11:52 INFO - PROCESS | 11279 | __metrics 14:11:53 ERROR - PROCESS | 11279 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:11:53 INFO - PROCESS | 11279 | console.error: PushService: 14:11:53 INFO - PROCESS | 11279 | stateChangeProcessEnqueue: Error transitioning state 14:11:53 INFO - PROCESS | 11279 | UnknownError 14:11:54 INFO - TEST-INFO | 11279: exit 0 14:11:54 INFO - Browser initialized. 14:11:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:11:54 INFO - TEST-INFO | started process 11360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv0w6wl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:12:05 INFO - PROCESS | 11360 | RSS: Main: 156164096 14:12:05 INFO - PROCESS | 11360 | 14:12:57 INFO - PROCESS | 11360 | 1465247577037 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:15:05 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:49157/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49157/tests/dromaeo/cssquery-ext.html) 14:15:06 INFO - PROCESS | 11360 | RSS: Main: 254443520 14:15:06 INFO - PROCESS | 11360 | 14:18:08 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:49157/tests/dromaeo/cssquery-ext.html (next: http://localhost:49157/tests/dromaeo/cssquery-jquery.html) 14:18:09 INFO - PROCESS | 11360 | RSS: Main: 245551104 14:18:09 INFO - PROCESS | 11360 | 14:21:11 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:49157/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49157/tests/dromaeo/cssquery-mootools.html) 14:21:11 INFO - PROCESS | 11360 | RSS: Main: 232898560 14:21:11 INFO - PROCESS | 11360 | 14:24:13 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:49157/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49157/tests/dromaeo/cssquery-prototype.html) 14:24:14 INFO - PROCESS | 11360 | RSS: Main: 237957120 14:24:14 INFO - PROCESS | 11360 | 14:27:17 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:49157/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49157/tests/dromaeo/cssquery-yui.html) 14:27:17 INFO - PROCESS | 11360 | RSS: Main: 219303936 14:27:17 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | Cycle 1(1): loaded http://localhost:49157/tests/dromaeo/cssquery-yui.html (next: http://localhost:49157/tests/dromaeo/cssquery-dojo.html) 14:30:20 INFO - PROCESS | 11360 | RSS: Main: 276164608 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | __start_tp_report 14:30:20 INFO - PROCESS | 11360 | _x_x_mozilla_page_load 14:30:20 INFO - PROCESS | 11360 | _x_x_mozilla_page_load_details 14:30:20 INFO - PROCESS | 11360 | |i|pagename|runs| 14:30:20 INFO - PROCESS | 11360 | |0;dojo.html;3114.2058775012374;3122.703343182397;3139.9372012559757;3163.2566346908457;3177.5074863396167;5321.946780532194;5377.542908852753;5427.1316589345715;5490.039243132451;5506.174073888914;5416.83749487516;5438.456154384559;5450.700211488366;5489.945100548994;5491.231227628125;4880.633952453562;4965.627577931669;4995.6003519718515;4999.425066117388;5161.509656582619;5058.898822023557;5064.1390963536105;5118.616103792212;5120.129577971754;5129.589632829365;4857.465678775332;4907.779149938261;4907.82822601209;4938.432080310774;4979.7261150636705;4941.085899108676;4956.207006878882;5027.874303142414;5031.547160755549;5070.822521211777;4979.676321039157;4986.326845875797;4994.175960966436;5002.499750025005;5043.873903152414;5233.162693968985;5300.416954135042;5381.112116500773;5446.564274858041;5453.918191227135;5880.617759845596;5900.409959004108;5906.881862362771;5914.97042514789;5931.6144450611;5734.541236701054;5881.705914704247;5891.499222566087;5956.315023772278;5958.791442299542;5399.1091469907415;5433.130699088127;5434.3207099112615;5531.363893152299;5537.972310138423;6057.151998720183;6059.878802424015;6060;6065.636061836216;6078.848028799227;5607.130894711327;5681.750014996776;5797.275340582427;5809.680467574324;5815.302163740378;5822.679752613647;5885.146653735184;5936.1095835625;5945.672987985616;5946.851328716817;5797.333306669787;5816.651000939957;5821.7089145543405;5831.271091113611;5860.267466566679;5605.8598535036135;5796;5854.326752423441;5862.70686465675;5880.0003999320215;4447.799849006802;4451.643868490513;4465.821367145278;4492.056668099735;4499.640028797754;3957.3668213085766;3964.484616999829;3967.603239676067;3987.8803635890968;4002.9199416012098;5303.124984377611;5399.37907140676;5414.377346605191;5494.697791621419;5503.449655034465;5901.970490147522;5911.172435858984;5916.792912248051;5933.851653708605;5953.851153721192;5520.66875987442;5524.530414914697;5530.419305972815;5533.3083364579425;5534.280543529316;4933.0380575788095;4934.506549345037;4955;4955.529224723646;5039.470855560114;6060.121282414026;6062.090686397076;6062.363451837582;6070;6070.726817293233;5864.589478736448;5873.94126058751;5874.500667443315;5876.823695289148;5878.823635290948;5873.853153671193;6017.578769486094;6086.843499735036;6091.847703807441;6141.986572215535;5796.478316951495;5838.678872661874;5841.18223448726;5846.093855452242;5846.94153058464;5598.356189038313;5892.175095486549;5940.079287710412;5961.940380596138;5965.403459654173;5672;5719.685417302088;5732.885342293214;5773.134029895549;5776.855578610568;5750.971245143747;5754.108113242454;5754.424557544212;5755.395683453345;5757.683327416865;5466.781328746805;5519.089350257163;5659.434056594308;5666.065099258576;5673.517750991212;5695.2311437957005;5804.448577385142;5804.6807425592;5807.82576522705;5807.8548036299435;5639.069553523623;5644.068728659725;5644.915326270191;5657.886842263214;5659 14:30:20 INFO - PROCESS | 11360 | |1;ext.html;585.2216551985856;619.340402471368;625.0624063904144;638.0524920493067;648.6626953983929;32554.837225813866;35350.64649353509;43631.345529817;44402.55597444025;44506;44939.55060449395;45503.54496455035;45542;45574.31638525416;45795.794294399406;8626.439281446686;8815.867761983576;8827.470351778913;8829.426087304337;8836.248918841875;8084.353251739847;10414.947925260363;10645;10665.466726663635;11055.170862185329;10799.028087472127;10957.890421095806;10962.725931851728;10965.50655220513;10967.396793176373;8195.344372450249;10440.269181157322;10867.728306792314;10932.234743567953;11004.339739615609;9905.20758339331;10420.531076101593;10426.374417534973;10442.164626829912;10442.947785261102;41371.37942930858;41904.37143442851;41908.58091419108;41947.58052419467;41958;3334.8832790852202;3606.8376923038527;3670.119171398872;3870.148567315186;3938.8030598469963;31807.20481987946;31993.84003079993;32591.348173036644;32592.348153036808;32678.836605816818;4206.600372964564;4317.611414972667;4370.541093185233;4423.314386270134;4431.645468362523;359814;363514;364455.9999999973;364556;365114;56223.43776562182;56509;56651.43348566544;56704;56749.71625141848;61234.77530449455;61449.69275153596;61459.38540614626;61528.38471615316;61605;16501.422450214184;16667.083310418042;16712.247948842087;16778.496645100666;16799.16004199785;12401.751964960831;12401.875981240253;12417.565385211474;12429.37853107341;12441.813372799415;15765.842341576667;16095.195240238176;16169.919150404172;16233;16320.755188671941;6156.969215153896;6175.2589689237575;6212.751489940351;6223.657698826518;6260.561760676709;739.6933494930873;1022.2792930983638;1041.671873359889;1053.6786280184617;1136.2727854173336;31777.8411107943;32250.677493225237;32392.190195245308;32579.67420325814;32849.67150328466;1107.5182295701395;1121.3328069798456;1151.407025381929;1177.4583691501834;1235.3452670084869;17135.65728685419;17241.82758172402;17317.567060823327;17355.91322043407;17426.88542891886;621149;625268;625918;626731;629065;57635.71182144062;57769.13346299809;57850;57896;57910.7104464475;1221.6029790318182;1312.5012495251742;1323.3978539764385;1343.06656873472;1353.9526116585873;29381.559276611297;30783.2304192397;33307;33764.15589610279;33789.66210337865;50983.23525147051;51579;51668;51771.482285176666;51783.74108129586;550736;559162;561308;561308.5803712866;561636;43213;44817.62188537396;45495.54504454913;45576.54423455723;45763.54236457593;49562.75218623884;49836.501634984634;50163.24755128749;50171.74914125406;50910.49089509206;40631.7968410156;41108;41800;41950.58049419467;42021;40017.79991100026;40555.39166912558;40651.59348406478;41374.1725165489;42028.3695744558;41011.58988410078;41283.1743365125;41393.37909931293;41821;41869;36086.45870312;36802.26395472022;36807.26385472329;37013.259734805695;37235;28096.465463845954;28663.71336286694;28715.13854584366;28736.568951466164;28791.856040719664 14:30:20 INFO - PROCESS | 11360 | |2;jquery.html;400.7475290566943;400.829647399855;403.4251192051326;405.43037032968687;423.3712936289609;17733.733993990085;18264.634707305846;19008.714869276955;19064.428067157973;19141.234350625957;17779.64440711185;17853.64292714145;18227.088645567703;18507.53731156722;18576.16407261673;5472.699001554923;5537.1140617501205;5711.742971566268;5777.62445441045;5787.623804452718;5735.684537350444;5740.425957404247;5761.366249712528;5769.394213607574;5788.073908174693;5469.042917489423;5627;5629.6340737852115;5641.2384328115795;5648.096304591266;5557.221988921554;5569.637973531728;5574.275344205268;5577.470140336662;5593.552515798747;4842.2736589511505;5067.214581739836;5068.873278168038;5074.340335756328;5081.28861959326;22038.33884983453;22085.447863803372;22722.318330450114;22751.089956401724;22802.315930522112;2383.5947888858936;2448.5102979404014;2507.122507122511;2632.526145293846;2665;14104;14197.290135493287;14245;14459.060161089601;14535.055221410574;1911.7897031326543;1921.625283069802;1940.1560321260297;1949.9805001950083;2030.2893987104544;45276.77361613171;45709.314360284625;47227;76793.61603192004;80095.39570719331;10058.245631577662;10674.345476451163;10681.359118452763;10771.246012779031;11026.614068507564;14773.113613183243;14888.776668349983;14897.553073407815;14950;14971;7563.886541701879;7631.961840190875;7668.846623067508;8116.391270654724;8215.178482151738;7740.458167928304;7749.883751743616;7964.044314682275;7971.880421793678;7982.600869956479;6322.620642761449;6426.3573642635365;6456.3543645636;6561.1470508833545;6569.507286953498;1817.9363722269657;1827.3421568235424;1912.8374088202381;1939.2340025689773;1939.4278687787137;416.2839915345601;984.0995489127369;1033.395463653756;1051.5057922776436;1104.7679987202616;11454.885451145381;11783.587574434854;11936.761264774656;12282.692932676577;12290.139690221777;437.29595351484085;448.1328629102697;448.35213117045555;448.9393931819228;475.96477661087;6385;6534.379233972765;6559.344065593403;6574.901376479356;6582.8354291143105;495885;499550;501485;528245;534517;95509;101902;101908.49045754723;101968;103045.48477257566;461.3494972089405;462.84032008956854;480.26759192232123;500.88980424306595;501.0680134948992;9807.362521436084;9949;10064.496775161359;10120.342177758423;10183.898161018591;41589.792051040764;41625.167496649294;41981.580184197766;42203.788981054895;42627.786861066736;52003;53624.73187634037;55812;60771.04988175754;63841.68079159575;7703.2268383380815;7809.804754880946;8127.512349259064;8180.263776260165;8447.324214062983;11527.423628818693;13038;13172.143810652276;13236.801447978482;13424.261665608485;10997.725056873642;11502.194846360675;11512.19414640967;11525.769484610428;11807;11342.60300889465;11353.205275630626;11637.301761894314;11698.532058717896;11789.882101178879;6270.623762574261;10382.273240873066;11610.825837612612;11736.178467507534;11866.228695134789;8030;8318.46108469935;8574.699885503978;8577.142285771373;8791.384603077979;8839.337049721426;9759.512024398893;10971.835422468828;11630.6510804676;11702.239354441934 14:30:20 INFO - PROCESS | 11360 | |3;mootools.html;1339.9397027133791;1448.3482432905191;1510.7658312961491;1639.967200655987;1824.9452516424512;8701.91298087019;9020.819583608323;9043.954780226099;9239.861402078957;9272.350935434522;8980.685676001342;9163.541822908845;9169.495677737721;9174.90825091749;9176.311776616747;2394.904203831845;2426.6360045993065;2428.550718117154;2430.040134147011;2433.0997530913587;2401.735809061002;2420.3828023853894;2439;2443.6823212982285;2446.070493212577;2402.9279121626378;2416.4321384474633;2438.2319569335605;2451.3136321829916;2453.33759884831;2285.1887579909144;2290.2442194075998;2292.106078629336;2294.724633044029;2346.7301260354934;2292.598795210848;2360.7875291223872;2365.66880636711;2366.8461549999197;2369.253685089209;7864.960675196645;8073.434859559833;9146.268298536168;9184.219341355993;9207.769805754842;4930.950690493121;5089.160288552384;5089.796408143669;5316.362036555638;5491.752871120809;3516.050666320105;3549.8757543486113;3576.660217279354;3603.927921441583;3614.1868079682126;1163.057923082306;1169.05306701572;1188.4176753390864;1201.6034708546158;2140.1225497545934;12249.326287054208;12303.75392492154;12357.38213089342;12414.255144691348;12485.50057997688;4477.686561940633;4611.769411529477;4684.484706682262;4715.834945776881;4738.668293219442;9601.087896649808;9619.27855410847;9622.941476437587;9623.711288661352;9654.71035868925;5285.762140703678;5286.127788914863;5287.629865909426;5290.603204759582;5297.046531624267;4791.736454494967;4891.5353041461;4952.5542701157065;4995.175795993693;5007.474215207423;3803.8858834235016;3817.568411845558;3888.9611103889165;3913.882583522499;3940.7832569208967;1121.9831702524468;1131.4682099413428;1148.661144962238;1148.9482973266222;1154.7979103656826;864.1919804982361;955.5604421965974;965.821323055237;978.6036655154674;984.7636567223958;5855.677937713466;5934.792282270186;6044.516438684895;6104.4200800923845;6193.163922870445;457.54702844184015;461.45087346058085;466.83427383279127;467.1357987722686;492.0577094863368;3974.503187101612;4249.87250382489;4258.850940217078;4288.48538175421;4373.234683930299;11309;11608.303501789751;11724.413779311;11737;11749.118816088827;10785.245032847783;11231.213815033032;11622.186446948801;11654.53381864716;11663.76672466563;8228.42401031922;8290.709825156211;8341.16588341161;8410.369222308229;8416;6043.153958445733;6212.161358216583;6222.688865556795;6292.339304372975;6367.140436041261;10390.480475976019;10771.138308935424;10834.891651083388;10890.727731806768;10892.782144357227;10679.305845120043;11002.614908478165;11015.504302306255;11047.502862371051;11147.498362573866;8094.271515563628;8138.674453022049;8194.057683366489;8201.42590018693;8214.26071653554;8784.253338466302;8834.072422395557;8851.026387097543;8878.556072196236;8921.107889211027;7864.21357864209;7909.841803164019;8155.306798922158;8171.101178870201;8274;7774;7778.338841198562;7920.207979202034;7926.920730792849;7930.920690793018;7203.459740519377;7212.350888420067;7273.9636301818155;7275.163356214103;7277.781666550012;4946.08497427977;4980.302757614009;5016.795968967494;5091.643584949018;5112.747376892685;4997.950020499894;5037.899242015066;5069.7465126744255;5123.052235336475;5136.871578210575 14:30:20 INFO - PROCESS | 11360 | |4;prototype.html;323.16945450193;329.904327744954;333.71467395376953;338.2457120621015;341.8393355123091;5262.9473705262935;5282.603804714652;5315.149576067825;5341.385740639827;5392.78428862845;5011.797168679509;5037.798488060474;5182.512394050857;5255.264263003182;5321.787128514865;4093.833257521607;4102.569230230828;4108.36320370343;4143.357779544175;4151.418801367811;4104;4110.260153172443;4128.071183983609;4130.6162435583965;4143.875683729478;3843.673287770543;3900.941485877714;4019.859304924328;4070.7354021988626;4124.793760311987;4061.086255592468;4079.2657321682086;4088.4480595119726;4098.52866920305;4103.507579090498;3635.8727444539577;3666.2319948439026;3668.0829792551863;3670.3576874047203;3679.3193259247123;5034.622403319766;5072.746362681851;5087;5105.310783044279;5163.561097306733;4690.929636055462;4718.834840780591;4718.905621887578;4735.715857048588;4740.5496477834895;5469.535089517396;5469.644473109235;5472.370677372073;5478.397376288605;5501.202325662796;3886.3198940185353;3951.585083566242;3977.4630424892557;3980.124372638015;4003.1793482336343;5621.522170615503;5622.269105016322;5639.548836093103;5650.74571644277;5673.241295198502;4084;4110.006646776311;4117.238310912491;4117.938230926538;4134.73124246923;3966.662833659171;4136.772477513706;4136.937945930814;4170;4174.415581818548;4686.578207961232;4687.10944920464;4696.1546921554445;4707.199776038082;4712.31671407644;5491.341039075336;5533.501984821385;5544.805931792368;5615.283162143819;5621.550275977994;1363.032247104547;1393.4844107680224;1408.845027047024;1438.4821464272854;1439.0142752214767;965.946872921996;997.0677416615488;999.195647503752;1000.8999100090078;1002.0510107840181;5175.844724658266;5276.3932147802725;5305;5358.812441564526;5413.404525502192;5650.237217975603;5684.573656975744;5688.77244910199;5692.747595528977;5694.1458781183155;5188.688678679216;5340.409901197916;5349.598780091509;5372.650777699437;5391.757370918318;2982.1799005273724;2996.8351740654475;3017.4719424100695;3019.350839569503;3048.557959095963;5797.88404231913;5802.21670074543;5814.59297849155;5842.444967728059;5842.853928651818;5592.679038199183;5715.914261286084;5720.370759216483;5742.684152371576;5783.248177736868;5736.282964629505;5754.1944127822135;5763.682997435181;5772;5813.7383817728305;5416.729163541729;5617.522510586482;5643.407442218672;5667.801626943037;5677.233573467529;5479.643823151482;5530.336359636869;5533.588934821595;5539.061328534981;5581.358143813513;5743.62666426681;5770.6249093808765;5771.134329850556;5837;5856.648601083949;3839.2723274527134;4071.6742660586488;4081.9591804082766;4110.835566577423;4137.91724165509;5685.687287199244;5722.74247658848;5737.655740655574;5766.135079738073;5772.307323121252;5399.973000134974;5478.561715062865;5577.860553486195;5600.327960644586;5640.915386269291;5474.945250547603;5489.670619762827;5583.972080139573;5586.916196257141;5588.13383925476;5260.421353651019;5334.493223143795;5406.75669594877;5502;5520.337559492887;5487.862803429946;5497.642653227527;5515.61390702647;5565.888682226414;5575.804846830341;5418.106012507892;5423;5463.9180412294645;5496.780128794963;5542.196381524575 14:30:20 INFO - PROCESS | 11360 | |5;yui.html;710.9573425594465;733.7028503456096;752.1801236652052;802.5104686141455;833.229262931788;14103.153810771348;15003.399864005454;15255.313510892009;15294.464693735708;15309.693806123898;14611.488597899075;15221.315040823161;15250.084994900286;15256.38974441021;15273.159976201305;678.0473434824055;799.8800179973022;803.835213781175;819.6270696832927;822.2805045585113;814.8899898513714;824.431142511668;825.4840724547158;825.859603867341;826.4132465949183;855.5337341149058;862.5471627395605;862.560094351882;862.633380813155;863.0377129500594;708.5465302206592;820.3765138494787;842.9199226073574;849.4054162086534;850.2645211891731;609.5732986909181;612.1796792298342;614.342653360904;614.3856143856144;615.2924137242162;14709.632259193606;14749.262536873113;14752.704945901129;14762.335694893756;14795.186264755434;13022.479100835955;13665;13768.655783605389;13997.440102395893;14310.069845460011;12124.878751212464;12141;12169.817452738216;12362.505499779998;12848.421821018077;4389.956100438987;4432.667549933768;4443.622292105175;4622.930656040162;4663.323818046364;76582.23417765807;76820.23179768243;77543;78416.60791696062;78909.21090789077;11029;11042.779144417067;11064.28082174656;11143.2199746017;11230.831537526943;20887.37337879866;20890.1643934244;20891;20920;20945.685814712793;7930.801729956797;8184.345252379795;8215.753527394188;8355.164483551718;8493.483267308477;4554.612857907115;4563.361129441881;4626.236670949323;4643.466001409881;4757;3331.816750078769;3439.6560343965402;3457.6542345765724;3466.0468371197617;3471.6181220065773;578.6528083150076;580.1674596953385;582.8834233153386;596.31126049413;620.5718054542351;569.7607005057886;620.43230444144;637.7225906730587;643.8583511627435;652.9738810447529;9117.544122793834;9170.67902623405;9278.907210927939;9359.719208423758;9385.62457501706;586.6186978464033;644.7453255963868;654.2345455816611;687.9277675844064;736.1644533454461;4633.328167415706;4696.788644511005;4937.802487900443;4986.177280748709;5007.949920500749;110796;113071.43464282627;114794;117203;120048;61163.38836611666;63406;65765.67117164479;101558.99999999852;102601;87522;88157;88464.5576772112;88493.55753221193;88591.11408885957;8787.692430765148;8852.3803333766;8880.822383552422;8921.15249051339;8968.148025937526;52411.73794131005;53614;54538.181927271915;54553;55628;74079.2592074094;79319.60340198262;80592;82105.58947205226;82213.58893205496;11800.468978896142;11904.821427678418;12150.513979440724;12233.143679942319;12266.570670026505;12678.366081695694;13105.14816536922;13118.540851070167;13341;13688.041837071309;12273;12277.324747138993;12393.814092788796;12430.564930227398;12800;12114.939425302817;12264.264144151379;12479.251244925334;12645.494180232688;12901.741965160456;11507.367094809866;11891.405429728651;11902.23903506603;11980.700482487659;12877.8068328977;9493.240540756584;9701.9029809701;9941.055599718014;9971.750706232402;10167.644132455329;10366.378017318984;10417.47912604382;10503.94748026255;10532;10614.681559553226 14:30:20 INFO - PROCESS | 11360 | __end_tp_report 14:30:20 INFO - PROCESS | 11360 | __start_cc_report 14:30:20 INFO - PROCESS | 11360 | _x_x_mozilla_cycle_collect,873 14:30:20 INFO - PROCESS | 11360 | __end_cc_report 14:30:20 INFO - PROCESS | 11360 | __startTimestamp1465248620561__endTimestamp 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | ------- Summary: start ------- 14:30:20 INFO - PROCESS | 11360 | Number of tests: 6 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | [#0] dojo.html Cycles:165 Average:5439.47 Median:5644.92 stddev:628.30 (11.1%) stddev-sans-first:603.17 14:30:20 INFO - PROCESS | 11360 | Values: 3114.2 3122.7 3139.9 3163.3 3177.5 5321.9 5377.5 5427.1 5490.0 5506.2 5416.8 5438.5 5450.7 5489.9 5491.2 4880.6 4965.6 4995.6 4999.4 5161.5 5058.9 5064.1 5118.6 5120.1 5129.6 4857.5 4907.8 4907.8 4938.4 4979.7 4941.1 4956.2 5027.9 5031.5 5070.8 4979.7 4986.3 4994.2 5002.5 5043.9 5233.2 5300.4 5381.1 5446.6 5453.9 5880.6 5900.4 5906.9 5915.0 5931.6 5734.5 5881.7 5891.5 5956.3 5958.8 5399.1 5433.1 5434.3 5531.4 5538.0 6057.2 6059.9 6060.0 6065.6 6078.8 5607.1 5681.8 5797.3 5809.7 5815.3 5822.7 5885.1 5936.1 5945.7 5946.9 5797.3 5816.7 5821.7 5831.3 5860.3 5605.9 5796.0 5854.3 5862.7 5880.0 4447.8 4451.6 4465.8 4492.1 4499.6 3957.4 3964.5 3967.6 3987.9 4002.9 5303.1 5399.4 5414.4 5494.7 5503.4 5902.0 5911.2 5916.8 5933.9 5953.9 5520.7 5524.5 5530.4 5533.3 5534.3 4933.0 4934.5 4955.0 4955.5 5039.5 6060.1 6062.1 6062.4 6070.0 6070.7 5864.6 5873.9 5874.5 5876.8 5878.8 5873.9 6017.6 6086.8 6091.8 6142.0 5796.5 5838.7 5841.2 5846.1 5846.9 5598.4 5892.2 5940.1 5961.9 5965.4 5672.0 5719.7 5732.9 5773.1 5776.9 5751.0 5754.1 5754.4 5755.4 5757.7 5466.8 5519.1 5659.4 5666.1 5673.5 5695.2 5804.4 5804.7 5807.8 5807.9 5639.1 5644.1 5644.9 5657.9 5659.0 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | [#1] ext.html Cycles:180 Average:67093.91 Median:40641.70 stddev:140704.99 (346.2%) stddev-sans-first:141011.09 14:30:20 INFO - PROCESS | 11360 | Values: 585.2 619.3 625.1 638.1 648.7 32554.8 35350.6 43631.3 44402.6 44506.0 44939.6 45503.5 45542.0 45574.3 45795.8 8626.4 8815.9 8827.5 8829.4 8836.2 8084.4 10414.9 10645.0 10665.5 11055.2 10799.0 10957.9 10962.7 10965.5 10967.4 8195.3 10440.3 10867.7 10932.2 11004.3 9905.2 10420.5 10426.4 10442.2 10442.9 41371.4 41904.4 41908.6 41947.6 41958.0 3334.9 3606.8 3670.1 3870.1 3938.8 31807.2 31993.8 32591.3 32592.3 32678.8 4206.6 4317.6 4370.5 4423.3 4431.6 359814.0 363514.0 364456.0 364556.0 365114.0 56223.4 56509.0 56651.4 56704.0 56749.7 61234.8 61449.7 61459.4 61528.4 61605.0 16501.4 16667.1 16712.2 16778.5 16799.2 12401.8 12401.9 12417.6 12429.4 12441.8 15765.8 16095.2 16169.9 16233.0 16320.8 6157.0 6175.3 6212.8 6223.7 6260.6 739.7 1022.3 1041.7 1053.7 1136.3 31777.8 32250.7 32392.2 32579.7 32849.7 1107.5 1121.3 1151.4 1177.5 1235.3 17135.7 17241.8 17317.6 17355.9 17426.9 621149.0 625268.0 625918.0 626731.0 629065.0 57635.7 57769.1 57850.0 57896.0 57910.7 1221.6 1312.5 1323.4 1343.1 1354.0 29381.6 30783.2 33307.0 33764.2 33789.7 50983.2 51579.0 51668.0 51771.5 51783.7 550736.0 559162.0 561308.0 561308.6 561636.0 43213.0 44817.6 45495.5 45576.5 45763.5 49562.8 49836.5 50163.2 50171.7 50910.5 40631.8 41108.0 41800.0 41950.6 42021.0 40017.8 40555.4 40651.6 41374.2 42028.4 41011.6 41283.2 41393.4 41821.0 41869.0 36086.5 36802.3 36807.3 37013.3 37235.0 28096.5 28663.7 28715.1 28736.6 28791.9 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | [#2] jquery.html Cycles:180 Average:28625.28 Median:21313.58 stddev:84389.41 (395.9%) stddev-sans-first:84599.53 14:30:20 INFO - PROCESS | 11360 | Values: 400.7 400.8 403.4 405.4 423.4 17733.7 18264.6 19008.7 19064.4 19141.2 17779.6 17853.6 18227.1 18507.5 18576.2 5472.7 5537.1 5711.7 5777.6 5787.6 5735.7 5740.4 5761.4 5769.4 5788.1 5469.0 5627.0 5629.6 5641.2 5648.1 5557.2 5569.6 5574.3 5577.5 5593.6 4842.3 5067.2 5068.9 5074.3 5081.3 22038.3 22085.4 22722.3 22751.1 22802.3 2383.6 2448.5 2507.1 2632.5 2665.0 14104.0 14197.3 14245.0 14459.1 14535.1 1911.8 1921.6 1940.2 1950.0 2030.3 45276.8 45709.3 47227.0 76793.6 80095.4 10058.2 10674.3 10681.4 10771.2 11026.6 14773.1 14888.8 14897.6 14950.0 14971.0 7563.9 7632.0 7668.8 8116.4 8215.2 7740.5 7749.9 7964.0 7971.9 7982.6 6322.6 6426.4 6456.4 6561.1 6569.5 1817.9 1827.3 1912.8 1939.2 1939.4 416.3 984.1 1033.4 1051.5 1104.8 11454.9 11783.6 11936.8 12282.7 12290.1 437.3 448.1 448.4 448.9 476.0 6385.0 6534.4 6559.3 6574.9 6582.8 495885.0 499550.0 501485.0 528245.0 534517.0 95509.0 101902.0 101908.5 101968.0 103045.5 461.3 462.8 480.3 500.9 501.1 9807.4 9949.0 10064.5 10120.3 10183.9 41589.8 41625.2 41981.6 42203.8 42627.8 52003.0 53624.7 55812.0 60771.0 63841.7 7703.2 7809.8 8127.5 8180.3 8447.3 11527.4 13038.0 13172.1 13236.8 13424.3 10997.7 11502.2 11512.2 11525.8 11807.0 11342.6 11353.2 11637.3 11698.5 11789.9 6270.6 10382.3 11610.8 11736.2 11866.2 8030.0 8318.5 8574.7 8577.1 8791.4 8839.3 9759.5 10971.8 11630.7 11702.2 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | [#3] mootools.html Cycles:180 Average:5935.32 Median:2691.80 stddev:3434.63 (127.6%) stddev-sans-first:3426.90 14:30:20 INFO - PROCESS | 11360 | Values: 1339.9 1448.3 1510.8 1640.0 1824.9 8701.9 9020.8 9044.0 9239.9 9272.4 8980.7 9163.5 9169.5 9174.9 9176.3 2394.9 2426.6 2428.6 2430.0 2433.1 2401.7 2420.4 2439.0 2443.7 2446.1 2402.9 2416.4 2438.2 2451.3 2453.3 2285.2 2290.2 2292.1 2294.7 2346.7 2292.6 2360.8 2365.7 2366.8 2369.3 7865.0 8073.4 9146.3 9184.2 9207.8 4931.0 5089.2 5089.8 5316.4 5491.8 3516.1 3549.9 3576.7 3603.9 3614.2 1163.1 1169.1 1188.4 1201.6 2140.1 12249.3 12303.8 12357.4 12414.3 12485.5 4477.7 4611.8 4684.5 4715.8 4738.7 9601.1 9619.3 9622.9 9623.7 9654.7 5285.8 5286.1 5287.6 5290.6 5297.0 4791.7 4891.5 4952.6 4995.2 5007.5 3803.9 3817.6 3889.0 3913.9 3940.8 1122.0 1131.5 1148.7 1148.9 1154.8 864.2 955.6 965.8 978.6 984.8 5855.7 5934.8 6044.5 6104.4 6193.2 457.5 461.5 466.8 467.1 492.1 3974.5 4249.9 4258.9 4288.5 4373.2 11309.0 11608.3 11724.4 11737.0 11749.1 10785.2 11231.2 11622.2 11654.5 11663.8 8228.4 8290.7 8341.2 8410.4 8416.0 6043.2 6212.2 6222.7 6292.3 6367.1 10390.5 10771.1 10834.9 10890.7 10892.8 10679.3 11002.6 11015.5 11047.5 11147.5 8094.3 8138.7 8194.1 8201.4 8214.3 8784.3 8834.1 8851.0 8878.6 8921.1 7864.2 7909.8 8155.3 8171.1 8274.0 7774.0 7778.3 7920.2 7926.9 7930.9 7203.5 7212.4 7274.0 7275.2 7277.8 4946.1 4980.3 5016.8 5091.6 5112.7 4998.0 5037.9 5069.7 5123.1 5136.9 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | [#4] prototype.html Cycles:180 Average:4650.46 Median:5337.45 stddev:1356.71 (25.4%) stddev-sans-first:1321.07 14:30:20 INFO - PROCESS | 11360 | Values: 323.2 329.9 333.7 338.2 341.8 5262.9 5282.6 5315.1 5341.4 5392.8 5011.8 5037.8 5182.5 5255.3 5321.8 4093.8 4102.6 4108.4 4143.4 4151.4 4104.0 4110.3 4128.1 4130.6 4143.9 3843.7 3900.9 4019.9 4070.7 4124.8 4061.1 4079.3 4088.4 4098.5 4103.5 3635.9 3666.2 3668.1 3670.4 3679.3 5034.6 5072.7 5087.0 5105.3 5163.6 4690.9 4718.8 4718.9 4735.7 4740.5 5469.5 5469.6 5472.4 5478.4 5501.2 3886.3 3951.6 3977.5 3980.1 4003.2 5621.5 5622.3 5639.5 5650.7 5673.2 4084.0 4110.0 4117.2 4117.9 4134.7 3966.7 4136.8 4136.9 4170.0 4174.4 4686.6 4687.1 4696.2 4707.2 4712.3 5491.3 5533.5 5544.8 5615.3 5621.6 1363.0 1393.5 1408.8 1438.5 1439.0 965.9 997.1 999.2 1000.9 1002.1 5175.8 5276.4 5305.0 5358.8 5413.4 5650.2 5684.6 5688.8 5692.7 5694.1 5188.7 5340.4 5349.6 5372.7 5391.8 2982.2 2996.8 3017.5 3019.4 3048.6 5797.9 5802.2 5814.6 5842.4 5842.9 5592.7 5715.9 5720.4 5742.7 5783.2 5736.3 5754.2 5763.7 5772.0 5813.7 5416.7 5617.5 5643.4 5667.8 5677.2 5479.6 5530.3 5533.6 5539.1 5581.4 5743.6 5770.6 5771.1 5837.0 5856.6 3839.3 4071.7 4082.0 4110.8 4137.9 5685.7 5722.7 5737.7 5766.1 5772.3 5400.0 5478.6 5577.9 5600.3 5640.9 5474.9 5489.7 5584.0 5586.9 5588.1 5260.4 5334.5 5406.8 5502.0 5520.3 5487.9 5497.6 5515.6 5565.9 5575.8 5418.1 5423.0 5463.9 5496.8 5542.2 14:30:20 INFO - PROCESS | 11360 | 14:30:20 INFO - PROCESS | 11360 | [#5] yui.html Cycles:180 Average:20267.99 Median:4961.99 stddev:29450.83 (593.5%) stddev-sans-first:29496.83 14:30:20 INFO - PROCESS | 11360 | Values: 711.0 733.7 752.2 802.5 833.2 14103.2 15003.4 15255.3 15294.5 15309.7 14611.5 15221.3 15250.1 15256.4 15273.2 678.0 799.9 803.8 819.6 822.3 814.9 824.4 825.5 825.9 826.4 855.5 862.5 862.6 862.6 863.0 708.5 820.4 842.9 849.4 850.3 609.6 612.2 614.3 614.4 615.3 14709.6 14749.3 14752.7 14762.3 14795.2 13022.5 13665.0 13768.7 13997.4 14310.1 12124.9 12141.0 12169.8 12362.5 12848.4 4390.0 4432.7 4443.6 4622.9 4663.3 76582.2 76820.2 77543.0 78416.6 78909.2 11029.0 11042.8 11064.3 11143.2 11230.8 20887.4 20890.2 20891.0 20920.0 20945.7 7930.8 8184.3 8215.8 8355.2 8493.5 4554.6 4563.4 4626.2 4643.5 4757.0 3331.8 3439.7 3457.7 3466.0 3471.6 578.7 580.2 582.9 596.3 620.6 569.8 620.4 637.7 643.9 653.0 9117.5 9170.7 9278.9 9359.7 9385.6 586.6 644.7 654.2 687.9 736.2 4633.3 4696.8 4937.8 4986.2 5007.9 110796.0 113071.4 114794.0 117203.0 120048.0 61163.4 63406.0 65765.7 101559.0 102601.0 87522.0 88157.0 88464.6 88493.6 88591.1 8787.7 8852.4 8880.8 8921.2 8968.1 52411.7 53614.0 54538.2 54553.0 55628.0 74079.3 79319.6 80592.0 82105.6 82213.6 11800.5 11904.8 12150.5 12233.1 12266.6 12678.4 13105.1 13118.5 13341.0 13688.0 12273.0 12277.3 12393.8 12430.6 12800.0 12114.9 12264.3 12479.3 12645.5 12901.7 11507.4 11891.4 11902.2 11980.7 12877.8 9493.2 9701.9 9941.1 9971.8 10167.6 10366.4 10417.5 10503.9 10532.0 10614.7 14:30:20 INFO - PROCESS | 11360 | -------- Summary: end -------- 14:30:20 INFO - PROCESS | 11360 | 14:30:21 INFO - TEST-INFO | 11360: exit 0 14:30:21 INFO - TEST-OK | dromaeo_css | took 1113572ms 14:30:21 INFO - TEST-START | kraken 14:30:21 INFO - operating with platform_type : linux_ 14:30:21 INFO - Initialising browser for kraken test... 14:30:21 INFO - TEST-INFO | started process 11543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9U33Mf/profile http://localhost:49157/getInfo.html) 14:30:25 INFO - PROCESS | 11543 | __metrics Screen width/height:1600/1200 14:30:25 INFO - PROCESS | 11543 | colorDepth:24 14:30:25 INFO - PROCESS | 11543 | Browser inner width/height: 1024/697 14:30:25 INFO - PROCESS | 11543 | __metrics 14:30:26 ERROR - PROCESS | 11543 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:30:26 INFO - PROCESS | 11543 | console.error: PushService: 14:30:26 INFO - PROCESS | 11543 | stateChangeProcessEnqueue: Error transitioning state 14:30:26 INFO - PROCESS | 11543 | UnknownError 14:30:27 INFO - TEST-INFO | 11543: exit 0 14:30:27 INFO - Browser initialized. 14:30:27 INFO - Running cycle 1/1 for kraken test... 14:30:27 INFO - TEST-INFO | started process 11627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9U33Mf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:30:39 INFO - PROCESS | 11627 | RSS: Main: 156254208 14:30:39 INFO - PROCESS | 11627 | 14:30:42 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49157/tests/kraken/driver.html?testName=audio-beat-detection) 14:30:42 INFO - PROCESS | 11627 | RSS: Main: 214396928 14:30:42 INFO - PROCESS | 11627 | 14:30:45 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49157/tests/kraken/driver.html?testName=audio-dft) 14:30:46 INFO - PROCESS | 11627 | RSS: Main: 200974336 14:30:46 INFO - PROCESS | 11627 | 14:30:49 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49157/tests/kraken/driver.html?testName=audio-fft) 14:30:49 INFO - PROCESS | 11627 | RSS: Main: 268005376 14:30:49 INFO - PROCESS | 11627 | 14:30:52 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49157/tests/kraken/driver.html?testName=audio-oscillator) 14:30:52 INFO - PROCESS | 11627 | RSS: Main: 179687424 14:30:52 INFO - PROCESS | 11627 | 14:30:54 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49157/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:30:55 INFO - PROCESS | 11627 | RSS: Main: 183697408 14:30:55 INFO - PROCESS | 11627 | 14:30:58 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49157/tests/kraken/driver.html?testName=imaging-darkroom) 14:30:58 INFO - PROCESS | 11627 | RSS: Main: 219209728 14:30:58 INFO - PROCESS | 11627 | 14:31:02 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49157/tests/kraken/driver.html?testName=imaging-desaturate) 14:31:02 INFO - PROCESS | 11627 | RSS: Main: 219332608 14:31:02 INFO - PROCESS | 11627 | 14:31:05 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49157/tests/kraken/driver.html?testName=json-parse-financial) 14:31:06 INFO - PROCESS | 11627 | RSS: Main: 219611136 14:31:06 INFO - PROCESS | 11627 | 14:31:07 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49157/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:31:08 INFO - PROCESS | 11627 | RSS: Main: 206385152 14:31:08 INFO - PROCESS | 11627 | 14:31:10 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:31:10 INFO - PROCESS | 11627 | RSS: Main: 211648512 14:31:10 INFO - PROCESS | 11627 | 14:31:12 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:31:13 INFO - PROCESS | 11627 | RSS: Main: 218382336 14:31:13 INFO - PROCESS | 11627 | 14:31:15 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:31:16 INFO - PROCESS | 11627 | RSS: Main: 223047680 14:31:16 INFO - PROCESS | 11627 | 14:31:19 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:31:19 INFO - PROCESS | 11627 | RSS: Main: 222744576 14:31:19 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | Cycle 1(1): loaded http://localhost:49157/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49157/tests/kraken/driver.html?testName=ai-astar) 14:31:21 INFO - PROCESS | 11627 | RSS: Main: 264298496 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | __start_tp_report 14:31:21 INFO - PROCESS | 11627 | _x_x_mozilla_page_load 14:31:21 INFO - PROCESS | 11627 | _x_x_mozilla_page_load_details 14:31:21 INFO - PROCESS | 11627 | |i|pagename|runs| 14:31:21 INFO - PROCESS | 11627 | |0;ai-astar;111;105;113;111;112;110;110;110;111;110 14:31:21 INFO - PROCESS | 11627 | |1;audio-beat-detection;156;127;134;173;133;125;151;127;188;129 14:31:21 INFO - PROCESS | 11627 | |2;audio-dft;159;161;160;161;162;160;165;160;162;162 14:31:21 INFO - PROCESS | 11627 | |3;audio-fft;74;76;76;123;77;75;74;75;102;77 14:31:21 INFO - PROCESS | 11627 | |4;audio-oscillator;84;84;111;85;85;85;116;84;84;130 14:31:21 INFO - PROCESS | 11627 | |5;imaging-gaussian-blur;117;117;116;117;116;116;117;117;117;117 14:31:21 INFO - PROCESS | 11627 | |6;imaging-darkroom;145;146;146;145;145;146;146;145;145;145 14:31:21 INFO - PROCESS | 11627 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;96 14:31:21 INFO - PROCESS | 11627 | |8;json-parse-financial;54;53;52;54;52;53;54;52;52;53 14:31:21 INFO - PROCESS | 11627 | |9;json-stringify-tinderbox;63;63;63;63;65;64;64;63;63;64 14:31:21 INFO - PROCESS | 11627 | |10;stanford-crypto-aes;77;81;78;79;79;80;80;81;109;80 14:31:21 INFO - PROCESS | 11627 | |11;stanford-crypto-ccm;128;128;127;118;127;119;129;121;132;122 14:31:21 INFO - PROCESS | 11627 | |12;stanford-crypto-pbkdf2;159;163;162;159;161;160;159;163;162;159 14:31:21 INFO - PROCESS | 11627 | |13;stanford-crypto-sha256-iterative;63;63;63;61;62;62;64;63;62;60 14:31:21 INFO - PROCESS | 11627 | __end_tp_report 14:31:21 INFO - PROCESS | 11627 | __start_cc_report 14:31:21 INFO - PROCESS | 11627 | _x_x_mozilla_cycle_collect,1626 14:31:21 INFO - PROCESS | 11627 | __end_cc_report 14:31:21 INFO - PROCESS | 11627 | __startTimestamp1465248681771__endTimestamp 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | ------- Summary: start ------- 14:31:21 INFO - PROCESS | 11627 | Number of tests: 14 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.11 (1.9%) stddev-sans-first:2.22 14:31:21 INFO - PROCESS | 11627 | Values: 111.0 105.0 113.0 111.0 112.0 110.0 110.0 110.0 111.0 110.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:142.50 stddev:22.00 (15.4%) stddev-sans-first:22.92 14:31:21 INFO - PROCESS | 11627 | Values: 156.0 127.0 134.0 173.0 133.0 125.0 151.0 127.0 188.0 129.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.69 (1.0%) stddev-sans-first:1.59 14:31:21 INFO - PROCESS | 11627 | Values: 159.0 161.0 160.0 161.0 162.0 160.0 165.0 160.0 162.0 162.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.50 stddev:16.40 (21.7%) stddev-sans-first:17.08 14:31:21 INFO - PROCESS | 11627 | Values: 74.0 76.0 76.0 123.0 77.0 75.0 74.0 75.0 102.0 77.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:84.00 stddev:17.34 (20.6%) stddev-sans-first:17.94 14:31:21 INFO - PROCESS | 11627 | Values: 84.0 84.0 111.0 85.0 85.0 85.0 116.0 84.0 84.0 130.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 14:31:21 INFO - PROCESS | 11627 | Values: 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:31:21 INFO - PROCESS | 11627 | Values: 145.0 146.0 146.0 145.0 145.0 146.0 146.0 145.0 145.0 145.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 14:31:21 INFO - PROCESS | 11627 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 96.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.88 (1.7%) stddev-sans-first:0.83 14:31:21 INFO - PROCESS | 11627 | Values: 54.0 53.0 52.0 54.0 52.0 53.0 54.0 52.0 52.0 53.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 14:31:21 INFO - PROCESS | 11627 | Values: 63.0 63.0 63.0 63.0 65.0 64.0 64.0 63.0 63.0 64.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:80.00 stddev:9.43 (11.8%) stddev-sans-first:9.80 14:31:21 INFO - PROCESS | 11627 | Values: 77.0 81.0 78.0 79.0 79.0 80.0 80.0 81.0 109.0 80.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:127.50 stddev:4.72 (3.7%) stddev-sans-first:4.89 14:31:21 INFO - PROCESS | 11627 | Values: 128.0 128.0 127.0 118.0 127.0 119.0 129.0 121.0 132.0 122.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:161.50 stddev:1.70 (1.1%) stddev-sans-first:1.69 14:31:21 INFO - PROCESS | 11627 | Values: 159.0 163.0 162.0 159.0 161.0 160.0 159.0 163.0 162.0 159.0 14:31:21 INFO - PROCESS | 11627 | 14:31:21 INFO - PROCESS | 11627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:63.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 14:31:21 INFO - PROCESS | 11627 | Values: 63.0 63.0 63.0 61.0 62.0 62.0 64.0 63.0 62.0 60.0 14:31:21 INFO - PROCESS | 11627 | -------- Summary: end -------- 14:31:21 INFO - PROCESS | 11627 | 14:31:22 INFO - TEST-INFO | 11627: exit 0 14:31:22 INFO - TEST-OK | kraken | took 61462ms 14:31:22 INFO - SUITE-END | took 1175s 14:31:22 INFO - Completed test suite (00:19:35) 14:31:22 INFO - javascript benchmark 14:31:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3114.2058775012374, 3122.703343182397, 3139.9372012559757, 3163.2566346908457, 3177.5074863396167, 5321.946780532194, 5377.542908852753, 5427.1316589345715, 5490.039243132451, 5506.174073888914, 5416.83749487516, 5438.456154384559, 5450.700211488366, 5489.945100548994, 5491.231227628125, 4880.633952453562, 4965.627577931669, 4995.6003519718515, 4999.425066117388, 5161.509656582619, 5058.898822023557, 5064.1390963536105, 5118.616103792212, 5120.129577971754, 5129.589632829365, 4857.465678775332, 4907.779149938261, 4907.82822601209, 4938.432080310774, 4979.7261150636705, 4941.085899108676, 4956.207006878882, 5027.874303142414, 5031.547160755549, 5070.822521211777, 4979.676321039157, 4986.326845875797, 4994.175960966436, 5002.499750025005, 5043.873903152414, 5233.162693968985, 5300.416954135042, 5381.112116500773, 5446.564274858041, 5453.918191227135, 5880.617759845596, 5900.409959004108, 5906.881862362771, 5914.97042514789, 5931.6144450611, 5734.541236701054, 5881.705914704247, 5891.499222566087, 5956.315023772278, 5958.791442299542, 5399.1091469907415, 5433.130699088127, 5434.3207099112615, 5531.363893152299, 5537.972310138423, 6057.151998720183, 6059.878802424015, 6060.0, 6065.636061836216, 6078.848028799227, 5607.130894711327, 5681.750014996776, 5797.275340582427, 5809.680467574324, 5815.302163740378, 5822.679752613647, 5885.146653735184, 5936.1095835625, 5945.672987985616, 5946.851328716817, 5797.333306669787, 5816.651000939957, 5821.7089145543405, 5831.271091113611, 5860.267466566679, 5605.8598535036135, 5796.0, 5854.326752423441, 5862.70686465675, 5880.0003999320215, 4447.799849006802, 4451.643868490513, 4465.821367145278, 4492.056668099735, 4499.640028797754, 3957.3668213085766, 3964.484616999829, 3967.603239676067, 3987.8803635890968, 4002.9199416012098, 5303.124984377611, 5399.37907140676, 5414.377346605191, 5494.697791621419, 5503.449655034465, 5901.970490147522, 5911.172435858984, 5916.792912248051, 5933.851653708605, 5953.851153721192, 5520.66875987442, 5524.530414914697, 5530.419305972815, 5533.3083364579425, 5534.280543529316, 4933.0380575788095, 4934.506549345037, 4955.0, 4955.529224723646, 5039.470855560114, 6060.121282414026, 6062.090686397076, 6062.363451837582, 6070.0, 6070.726817293233, 5864.589478736448, 5873.94126058751, 5874.500667443315, 5876.823695289148, 5878.823635290948, 5873.853153671193, 6017.578769486094, 6086.843499735036, 6091.847703807441, 6141.986572215535, 5796.478316951495, 5838.678872661874, 5841.18223448726, 5846.093855452242, 5846.94153058464, 5598.356189038313, 5892.175095486549, 5940.079287710412, 5961.940380596138, 5965.403459654173, 5672.0, 5719.685417302088, 5732.885342293214, 5773.134029895549, 5776.855578610568, 5750.971245143747, 5754.108113242454, 5754.424557544212, 5755.395683453345, 5757.683327416865, 5466.781328746805, 5519.089350257163, 5659.434056594308, 5666.065099258576, 5673.517750991212, 5695.2311437957005, 5804.448577385142, 5804.6807425592, 5807.82576522705, 5807.8548036299435, 5639.069553523623, 5644.068728659725, 5644.915326270191, 5657.886842263214, 5659.0], "value": 5396.350009194009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.2216551985856, 619.340402471368, 625.0624063904144, 638.0524920493067, 648.6626953983929, 32554.837225813866, 35350.64649353509, 43631.345529817, 44402.55597444025, 44506.0, 44939.55060449395, 45503.54496455035, 45542.0, 45574.31638525416, 45795.794294399406, 8626.439281446686, 8815.867761983576, 8827.470351778913, 8829.426087304337, 8836.248918841875, 8084.353251739847, 10414.947925260363, 10645.0, 10665.466726663635, 11055.170862185329, 10799.028087472127, 10957.890421095806, 10962.725931851728, 10965.50655220513, 10967.396793176373, 8195.344372450249, 10440.269181157322, 10867.728306792314, 10932.234743567953, 11004.339739615609, 9905.20758339331, 10420.531076101593, 10426.374417534973, 10442.164626829912, 10442.947785261102, 41371.37942930858, 41904.37143442851, 41908.58091419108, 41947.58052419467, 41958.0, 3334.8832790852202, 3606.8376923038527, 3670.119171398872, 3870.148567315186, 3938.8030598469963, 31807.20481987946, 31993.84003079993, 32591.348173036644, 32592.348153036808, 32678.836605816818, 4206.600372964564, 4317.611414972667, 4370.541093185233, 4423.314386270134, 4431.645468362523, 359814.0, 363514.0, 364455.9999999973, 364556.0, 365114.0, 56223.43776562182, 56509.0, 56651.43348566544, 56704.0, 56749.71625141848, 61234.77530449455, 61449.69275153596, 61459.38540614626, 61528.38471615316, 61605.0, 16501.422450214184, 16667.083310418042, 16712.247948842087, 16778.496645100666, 16799.16004199785, 12401.751964960831, 12401.875981240253, 12417.565385211474, 12429.37853107341, 12441.813372799415, 15765.842341576667, 16095.195240238176, 16169.919150404172, 16233.0, 16320.755188671941, 6156.969215153896, 6175.2589689237575, 6212.751489940351, 6223.657698826518, 6260.561760676709, 739.6933494930873, 1022.2792930983638, 1041.671873359889, 1053.6786280184617, 1136.2727854173336, 31777.8411107943, 32250.677493225237, 32392.190195245308, 32579.67420325814, 32849.67150328466, 1107.5182295701395, 1121.3328069798456, 1151.407025381929, 1177.4583691501834, 1235.3452670084869, 17135.65728685419, 17241.82758172402, 17317.567060823327, 17355.91322043407, 17426.88542891886, 621149.0, 625268.0, 625918.0, 626731.0, 629065.0, 57635.71182144062, 57769.13346299809, 57850.0, 57896.0, 57910.7104464475, 1221.6029790318182, 1312.5012495251742, 1323.3978539764385, 1343.06656873472, 1353.9526116585873, 29381.559276611297, 30783.2304192397, 33307.0, 33764.15589610279, 33789.66210337865, 50983.23525147051, 51579.0, 51668.0, 51771.482285176666, 51783.74108129586, 550736.0, 559162.0, 561308.0, 561308.5803712866, 561636.0, 43213.0, 44817.62188537396, 45495.54504454913, 45576.54423455723, 45763.54236457593, 49562.75218623884, 49836.501634984634, 50163.24755128749, 50171.74914125406, 50910.49089509206, 40631.7968410156, 41108.0, 41800.0, 41950.58049419467, 42021.0, 40017.79991100026, 40555.39166912558, 40651.59348406478, 41374.1725165489, 42028.3695744558, 41011.58988410078, 41283.1743365125, 41393.37909931293, 41821.0, 41869.0, 36086.45870312, 36802.26395472022, 36807.26385472329, 37013.259734805695, 37235.0, 28096.465463845954, 28663.71336286694, 28715.13854584366, 28736.568951466164, 28791.856040719664], "value": 20873.636337231314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.7475290566943, 400.829647399855, 403.4251192051326, 405.43037032968687, 423.3712936289609, 17733.733993990085, 18264.634707305846, 19008.714869276955, 19064.428067157973, 19141.234350625957, 17779.64440711185, 17853.64292714145, 18227.088645567703, 18507.53731156722, 18576.16407261673, 5472.699001554923, 5537.1140617501205, 5711.742971566268, 5777.62445441045, 5787.623804452718, 5735.684537350444, 5740.425957404247, 5761.366249712528, 5769.394213607574, 5788.073908174693, 5469.042917489423, 5627.0, 5629.6340737852115, 5641.2384328115795, 5648.096304591266, 5557.221988921554, 5569.637973531728, 5574.275344205268, 5577.470140336662, 5593.552515798747, 4842.2736589511505, 5067.214581739836, 5068.873278168038, 5074.340335756328, 5081.28861959326, 22038.33884983453, 22085.447863803372, 22722.318330450114, 22751.089956401724, 22802.315930522112, 2383.5947888858936, 2448.5102979404014, 2507.122507122511, 2632.526145293846, 2665.0, 14104.0, 14197.290135493287, 14245.0, 14459.060161089601, 14535.055221410574, 1911.7897031326543, 1921.625283069802, 1940.1560321260297, 1949.9805001950083, 2030.2893987104544, 45276.77361613171, 45709.314360284625, 47227.0, 76793.61603192004, 80095.39570719331, 10058.245631577662, 10674.345476451163, 10681.359118452763, 10771.246012779031, 11026.614068507564, 14773.113613183243, 14888.776668349983, 14897.553073407815, 14950.0, 14971.0, 7563.886541701879, 7631.961840190875, 7668.846623067508, 8116.391270654724, 8215.178482151738, 7740.458167928304, 7749.883751743616, 7964.044314682275, 7971.880421793678, 7982.600869956479, 6322.620642761449, 6426.3573642635365, 6456.3543645636, 6561.1470508833545, 6569.507286953498, 1817.9363722269657, 1827.3421568235424, 1912.8374088202381, 1939.2340025689773, 1939.4278687787137, 416.2839915345601, 984.0995489127369, 1033.395463653756, 1051.5057922776436, 1104.7679987202616, 11454.885451145381, 11783.587574434854, 11936.761264774656, 12282.692932676577, 12290.139690221777, 437.29595351484085, 448.1328629102697, 448.35213117045555, 448.9393931819228, 475.96477661087, 6385.0, 6534.379233972765, 6559.344065593403, 6574.901376479356, 6582.8354291143105, 495885.0, 499550.0, 501485.0, 528245.0, 534517.0, 95509.0, 101902.0, 101908.49045754723, 101968.0, 103045.48477257566, 461.3494972089405, 462.84032008956854, 480.26759192232123, 500.88980424306595, 501.0680134948992, 9807.362521436084, 9949.0, 10064.496775161359, 10120.342177758423, 10183.898161018591, 41589.792051040764, 41625.167496649294, 41981.580184197766, 42203.788981054895, 42627.786861066736, 52003.0, 53624.73187634037, 55812.0, 60771.04988175754, 63841.68079159575, 7703.2268383380815, 7809.804754880946, 8127.512349259064, 8180.263776260165, 8447.324214062983, 11527.423628818693, 13038.0, 13172.143810652276, 13236.801447978482, 13424.261665608485, 10997.725056873642, 11502.194846360675, 11512.19414640967, 11525.769484610428, 11807.0, 11342.60300889465, 11353.205275630626, 11637.301761894314, 11698.532058717896, 11789.882101178879, 6270.623762574261, 10382.273240873066, 11610.825837612612, 11736.178467507534, 11866.228695134789, 8030.0, 8318.46108469935, 8574.699885503978, 8577.142285771373, 8791.384603077979, 8839.337049721426, 9759.512024398893, 10971.835422468828, 11630.6510804676, 11702.239354441934], "value": 8410.74322749769, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1339.9397027133791, 1448.3482432905191, 1510.7658312961491, 1639.967200655987, 1824.9452516424512, 8701.91298087019, 9020.819583608323, 9043.954780226099, 9239.861402078957, 9272.350935434522, 8980.685676001342, 9163.541822908845, 9169.495677737721, 9174.90825091749, 9176.311776616747, 2394.904203831845, 2426.6360045993065, 2428.550718117154, 2430.040134147011, 2433.0997530913587, 2401.735809061002, 2420.3828023853894, 2439.0, 2443.6823212982285, 2446.070493212577, 2402.9279121626378, 2416.4321384474633, 2438.2319569335605, 2451.3136321829916, 2453.33759884831, 2285.1887579909144, 2290.2442194075998, 2292.106078629336, 2294.724633044029, 2346.7301260354934, 2292.598795210848, 2360.7875291223872, 2365.66880636711, 2366.8461549999197, 2369.253685089209, 7864.960675196645, 8073.434859559833, 9146.268298536168, 9184.219341355993, 9207.769805754842, 4930.950690493121, 5089.160288552384, 5089.796408143669, 5316.362036555638, 5491.752871120809, 3516.050666320105, 3549.8757543486113, 3576.660217279354, 3603.927921441583, 3614.1868079682126, 1163.057923082306, 1169.05306701572, 1188.4176753390864, 1201.6034708546158, 2140.1225497545934, 12249.326287054208, 12303.75392492154, 12357.38213089342, 12414.255144691348, 12485.50057997688, 4477.686561940633, 4611.769411529477, 4684.484706682262, 4715.834945776881, 4738.668293219442, 9601.087896649808, 9619.27855410847, 9622.941476437587, 9623.711288661352, 9654.71035868925, 5285.762140703678, 5286.127788914863, 5287.629865909426, 5290.603204759582, 5297.046531624267, 4791.736454494967, 4891.5353041461, 4952.5542701157065, 4995.175795993693, 5007.474215207423, 3803.8858834235016, 3817.568411845558, 3888.9611103889165, 3913.882583522499, 3940.7832569208967, 1121.9831702524468, 1131.4682099413428, 1148.661144962238, 1148.9482973266222, 1154.7979103656826, 864.1919804982361, 955.5604421965974, 965.821323055237, 978.6036655154674, 984.7636567223958, 5855.677937713466, 5934.792282270186, 6044.516438684895, 6104.4200800923845, 6193.163922870445, 457.54702844184015, 461.45087346058085, 466.83427383279127, 467.1357987722686, 492.0577094863368, 3974.503187101612, 4249.87250382489, 4258.850940217078, 4288.48538175421, 4373.234683930299, 11309.0, 11608.303501789751, 11724.413779311, 11737.0, 11749.118816088827, 10785.245032847783, 11231.213815033032, 11622.186446948801, 11654.53381864716, 11663.76672466563, 8228.42401031922, 8290.709825156211, 8341.16588341161, 8410.369222308229, 8416.0, 6043.153958445733, 6212.161358216583, 6222.688865556795, 6292.339304372975, 6367.140436041261, 10390.480475976019, 10771.138308935424, 10834.891651083388, 10890.727731806768, 10892.782144357227, 10679.305845120043, 11002.614908478165, 11015.504302306255, 11047.502862371051, 11147.498362573866, 8094.271515563628, 8138.674453022049, 8194.057683366489, 8201.42590018693, 8214.26071653554, 8784.253338466302, 8834.072422395557, 8851.026387097543, 8878.556072196236, 8921.107889211027, 7864.21357864209, 7909.841803164019, 8155.306798922158, 8171.101178870201, 8274.0, 7774.0, 7778.338841198562, 7920.207979202034, 7926.920730792849, 7930.920690793018, 7203.459740519377, 7212.350888420067, 7273.9636301818155, 7275.163356214103, 7277.781666550012, 4946.08497427977, 4980.302757614009, 5016.795968967494, 5091.643584949018, 5112.747376892685, 4997.950020499894, 5037.899242015066, 5069.7465126744255, 5123.052235336475, 5136.871578210575], "value": 4653.991251608102, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.16945450193, 329.904327744954, 333.71467395376953, 338.2457120621015, 341.8393355123091, 5262.9473705262935, 5282.603804714652, 5315.149576067825, 5341.385740639827, 5392.78428862845, 5011.797168679509, 5037.798488060474, 5182.512394050857, 5255.264263003182, 5321.787128514865, 4093.833257521607, 4102.569230230828, 4108.36320370343, 4143.357779544175, 4151.418801367811, 4104.0, 4110.260153172443, 4128.071183983609, 4130.6162435583965, 4143.875683729478, 3843.673287770543, 3900.941485877714, 4019.859304924328, 4070.7354021988626, 4124.793760311987, 4061.086255592468, 4079.2657321682086, 4088.4480595119726, 4098.52866920305, 4103.507579090498, 3635.8727444539577, 3666.2319948439026, 3668.0829792551863, 3670.3576874047203, 3679.3193259247123, 5034.622403319766, 5072.746362681851, 5087.0, 5105.310783044279, 5163.561097306733, 4690.929636055462, 4718.834840780591, 4718.905621887578, 4735.715857048588, 4740.5496477834895, 5469.535089517396, 5469.644473109235, 5472.370677372073, 5478.397376288605, 5501.202325662796, 3886.3198940185353, 3951.585083566242, 3977.4630424892557, 3980.124372638015, 4003.1793482336343, 5621.522170615503, 5622.269105016322, 5639.548836093103, 5650.74571644277, 5673.241295198502, 4084.0, 4110.006646776311, 4117.238310912491, 4117.938230926538, 4134.73124246923, 3966.662833659171, 4136.772477513706, 4136.937945930814, 4170.0, 4174.415581818548, 4686.578207961232, 4687.10944920464, 4696.1546921554445, 4707.199776038082, 4712.31671407644, 5491.341039075336, 5533.501984821385, 5544.805931792368, 5615.283162143819, 5621.550275977994, 1363.032247104547, 1393.4844107680224, 1408.845027047024, 1438.4821464272854, 1439.0142752214767, 965.946872921996, 997.0677416615488, 999.195647503752, 1000.8999100090078, 1002.0510107840181, 5175.844724658266, 5276.3932147802725, 5305.0, 5358.812441564526, 5413.404525502192, 5650.237217975603, 5684.573656975744, 5688.77244910199, 5692.747595528977, 5694.1458781183155, 5188.688678679216, 5340.409901197916, 5349.598780091509, 5372.650777699437, 5391.757370918318, 2982.1799005273724, 2996.8351740654475, 3017.4719424100695, 3019.350839569503, 3048.557959095963, 5797.88404231913, 5802.21670074543, 5814.59297849155, 5842.444967728059, 5842.853928651818, 5592.679038199183, 5715.914261286084, 5720.370759216483, 5742.684152371576, 5783.248177736868, 5736.282964629505, 5754.1944127822135, 5763.682997435181, 5772.0, 5813.7383817728305, 5416.729163541729, 5617.522510586482, 5643.407442218672, 5667.801626943037, 5677.233573467529, 5479.643823151482, 5530.336359636869, 5533.588934821595, 5539.061328534981, 5581.358143813513, 5743.62666426681, 5770.6249093808765, 5771.134329850556, 5837.0, 5856.648601083949, 3839.2723274527134, 4071.6742660586488, 4081.9591804082766, 4110.835566577423, 4137.91724165509, 5685.687287199244, 5722.74247658848, 5737.655740655574, 5766.135079738073, 5772.307323121252, 5399.973000134974, 5478.561715062865, 5577.860553486195, 5600.327960644586, 5640.915386269291, 5474.945250547603, 5489.670619762827, 5583.972080139573, 5586.916196257141, 5588.13383925476, 5260.421353651019, 5334.493223143795, 5406.75669594877, 5502.0, 5520.337559492887, 5487.862803429946, 5497.642653227527, 5515.61390702647, 5565.888682226414, 5575.804846830341, 5418.106012507892, 5423.0, 5463.9180412294645, 5496.780128794963, 5542.196381524575], "value": 4221.924294956959, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.9573425594465, 733.7028503456096, 752.1801236652052, 802.5104686141455, 833.229262931788, 14103.153810771348, 15003.399864005454, 15255.313510892009, 15294.464693735708, 15309.693806123898, 14611.488597899075, 15221.315040823161, 15250.084994900286, 15256.38974441021, 15273.159976201305, 678.0473434824055, 799.8800179973022, 803.835213781175, 819.6270696832927, 822.2805045585113, 814.8899898513714, 824.431142511668, 825.4840724547158, 825.859603867341, 826.4132465949183, 855.5337341149058, 862.5471627395605, 862.560094351882, 862.633380813155, 863.0377129500594, 708.5465302206592, 820.3765138494787, 842.9199226073574, 849.4054162086534, 850.2645211891731, 609.5732986909181, 612.1796792298342, 614.342653360904, 614.3856143856144, 615.2924137242162, 14709.632259193606, 14749.262536873113, 14752.704945901129, 14762.335694893756, 14795.186264755434, 13022.479100835955, 13665.0, 13768.655783605389, 13997.440102395893, 14310.069845460011, 12124.878751212464, 12141.0, 12169.817452738216, 12362.505499779998, 12848.421821018077, 4389.956100438987, 4432.667549933768, 4443.622292105175, 4622.930656040162, 4663.323818046364, 76582.23417765807, 76820.23179768243, 77543.0, 78416.60791696062, 78909.21090789077, 11029.0, 11042.779144417067, 11064.28082174656, 11143.2199746017, 11230.831537526943, 20887.37337879866, 20890.1643934244, 20891.0, 20920.0, 20945.685814712793, 7930.801729956797, 8184.345252379795, 8215.753527394188, 8355.164483551718, 8493.483267308477, 4554.612857907115, 4563.361129441881, 4626.236670949323, 4643.466001409881, 4757.0, 3331.816750078769, 3439.6560343965402, 3457.6542345765724, 3466.0468371197617, 3471.6181220065773, 578.6528083150076, 580.1674596953385, 582.8834233153386, 596.31126049413, 620.5718054542351, 569.7607005057886, 620.43230444144, 637.7225906730587, 643.8583511627435, 652.9738810447529, 9117.544122793834, 9170.67902623405, 9278.907210927939, 9359.719208423758, 9385.62457501706, 586.6186978464033, 644.7453255963868, 654.2345455816611, 687.9277675844064, 736.1644533454461, 4633.328167415706, 4696.788644511005, 4937.802487900443, 4986.177280748709, 5007.949920500749, 110796.0, 113071.43464282627, 114794.0, 117203.0, 120048.0, 61163.38836611666, 63406.0, 65765.67117164479, 101558.99999999852, 102601.0, 87522.0, 88157.0, 88464.5576772112, 88493.55753221193, 88591.11408885957, 8787.692430765148, 8852.3803333766, 8880.822383552422, 8921.15249051339, 8968.148025937526, 52411.73794131005, 53614.0, 54538.181927271915, 54553.0, 55628.0, 74079.2592074094, 79319.60340198262, 80592.0, 82105.58947205226, 82213.58893205496, 11800.468978896142, 11904.821427678418, 12150.513979440724, 12233.143679942319, 12266.570670026505, 12678.366081695694, 13105.14816536922, 13118.540851070167, 13341.0, 13688.041837071309, 12273.0, 12277.324747138993, 12393.814092788796, 12430.564930227398, 12800.0, 12114.939425302817, 12264.264144151379, 12479.251244925334, 12645.494180232688, 12901.741965160456, 11507.367094809866, 11891.405429728651, 11902.23903506603, 11980.700482487659, 12877.8068328977, 9493.240540756584, 9701.9029809701, 9941.055599718014, 9971.750706232402, 10167.644132455329, 10366.378017318984, 10417.47912604382, 10503.94748026255, 10532.0, 10614.681559553226], "value": 7323.500923140954, "unit": "score"}], "name": "dromaeo_css", "value": 7174.176992923202, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 113.0, 111.0, 112.0, 110.0, 110.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 127.0, 134.0, 173.0, 133.0, 125.0, 151.0, 127.0, 188.0, 129.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 160.0, 161.0, 162.0, 160.0, 165.0, 160.0, 162.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 123.0, 77.0, 75.0, 74.0, 75.0, 102.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 85.0, 85.0, 85.0, 116.0, 84.0, 84.0, 130.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 52.0, 54.0, 52.0, 53.0, 54.0, 52.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 65.0, 64.0, 64.0, 63.0, 63.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 78.0, 79.0, 79.0, 80.0, 80.0, 81.0, 109.0, 80.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 127.0, 118.0, 127.0, 119.0, 129.0, 121.0, 132.0, 122.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 162.0, 159.0, 161.0, 160.0, 159.0, 163.0, 162.0, 159.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 61.0, 62.0, 62.0, 64.0, 63.0, 62.0, 60.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1497.4, "alertThreshold": 2.0}]} 14:31:23 INFO - Return code: 0 14:31:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:31:23 ERROR - # TBPL SUCCESS # 14:31:23 INFO - Running post-action listener: _resource_record_post_action 14:31:23 INFO - ##### 14:31:23 INFO - ##### Finished run-tests step (success) 14:31:23 INFO - ##### 14:31:23 INFO - Running post-run listener: _resource_record_post_run 14:31:23 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 306376704; Read time: 0; Write time: 240904 14:31:23 INFO - TinderboxPrint: CPU usage
13.1% 14:31:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 14:31:23 INFO - TinderboxPrint: I/O write bytes / time
306,376,704 / 240,904 14:31:23 INFO - TinderboxPrint: CPU idle
8,271.2 (86.9%) 14:31:23 INFO - TinderboxPrint: CPU user
1,205.6 (12.7%) 14:31:23 INFO - TinderboxPrint: Swap in / out
0 / 0 14:31:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14184448; Read time: 0; Write time: 1936 14:31:23 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 292188160; Read time: 0; Write time: 238268 14:31:23 INFO - Running post-run listener: _upload_blobber_files 14:31:23 INFO - Blob upload gear active. 14:31:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:31:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:31:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:31:24 INFO - (blobuploader) - INFO - Open directory for files ... 14:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:24 INFO - (blobuploader) - INFO - Done attempting. 14:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:28 INFO - (blobuploader) - INFO - Done attempting. 14:31:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:31:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:31:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:31:28 INFO - (blobuploader) - INFO - Done attempting. 14:31:28 INFO - (blobuploader) - INFO - Iteration through files over. 14:31:28 INFO - Return code: 0 14:31:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:31:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:31:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40e5468e6330c5f10e2ae4013d6561c32cceca7ab101683bae3e22720316680f96a5181ad74d3f603d7968bd11ff504df0813d14e0fd107d8a0938b047480eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45d2bb00e8a554e87324ca9f6da190ffb7e52da59b589c9d9d0767ff6a58595ab80461ae2310ad4988c0c321032b43b25a8d20693f1ea251ed54d26746f085d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd162e9a171ee8b3c2727383a4951093ab346867fbbd479fe11db9d0a0ff7e7fcb5a62df0656d5af865d7e3cfdac2228e601dfd6119e86e014c2b8b77d5da5f0"} 14:31:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:31:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:31:28 INFO - Contents: 14:31:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40e5468e6330c5f10e2ae4013d6561c32cceca7ab101683bae3e22720316680f96a5181ad74d3f603d7968bd11ff504df0813d14e0fd107d8a0938b047480eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45d2bb00e8a554e87324ca9f6da190ffb7e52da59b589c9d9d0767ff6a58595ab80461ae2310ad4988c0c321032b43b25a8d20693f1ea251ed54d26746f085d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd162e9a171ee8b3c2727383a4951093ab346867fbbd479fe11db9d0a0ff7e7fcb5a62df0656d5af865d7e3cfdac2228e601dfd6119e86e014c2b8b77d5da5f0"} 14:31:28 INFO - Running post-run listener: copy_logs_to_upload_dir 14:31:28 INFO - Copying logs to upload dir... 14:31:28 INFO - mkdir: /builds/slave/test/build/upload/logs 14:31:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.989031 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-06 14:31:28.764635) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:28.767987) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40e5468e6330c5f10e2ae4013d6561c32cceca7ab101683bae3e22720316680f96a5181ad74d3f603d7968bd11ff504df0813d14e0fd107d8a0938b047480eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45d2bb00e8a554e87324ca9f6da190ffb7e52da59b589c9d9d0767ff6a58595ab80461ae2310ad4988c0c321032b43b25a8d20693f1ea251ed54d26746f085d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd162e9a171ee8b3c2727383a4951093ab346867fbbd479fe11db9d0a0ff7e7fcb5a62df0656d5af865d7e3cfdac2228e601dfd6119e86e014c2b8b77d5da5f0"} build_url:https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/M64v7G-MRcesjqsn-lR-IQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/40e5468e6330c5f10e2ae4013d6561c32cceca7ab101683bae3e22720316680f96a5181ad74d3f603d7968bd11ff504df0813d14e0fd107d8a0938b047480eb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/45d2bb00e8a554e87324ca9f6da190ffb7e52da59b589c9d9d0767ff6a58595ab80461ae2310ad4988c0c321032b43b25a8d20693f1ea251ed54d26746f085d6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bd162e9a171ee8b3c2727383a4951093ab346867fbbd479fe11db9d0a0ff7e7fcb5a62df0656d5af865d7e3cfdac2228e601dfd6119e86e014c2b8b77d5da5f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:28.793070) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:28.793382) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1465247226.978172-19255368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 14:31:28.877416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:31:28.877743) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 14:31:28.878055) ========= ========= Total master_lag: 0.20 =========