builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1465063517.78 results: success (0) buildid: 20160603235926 builduid: 23468869636e47d1847ad042fc69afbe revision: c2778bbb1938f995a1e3941c0f3c28c6872893f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.784592) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.785047) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.785334) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.826072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.826333) ========= 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=232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-04 11:05:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-06-04 11:05:18 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124960 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.965403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:17.965701) ========= 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=232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017979 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.017077) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.017420) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c2778bbb1938f995a1e3941c0f3c28c6872893f4 --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 c2778bbb1938f995a1e3941c0f3c28c6872893f4 --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=232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-04 11:05:18,647 truncating revision to first 12 chars 2016-06-04 11:05:18,647 Setting DEBUG logging. 2016-06-04 11:05:18,647 attempt 1/10 2016-06-04 11:05:18,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c2778bbb1938?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-04 11:05:19,186 unpacking tar archive at: fx-team-c2778bbb1938/testing/mozharness/ program finished with exit code 0 elapsedTime=0.901129 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.931618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.931893) ========= script_repo_revision: c2778bbb1938f995a1e3941c0f3c28c6872893f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.932280) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.932581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-04 11:05:18.940023) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-04 11:05:18.940294) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:05:19 INFO - MultiFileLogger online at 20160604 11:05:19 in /builds/slave/test 11:05:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:05:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:05:19 INFO - {'append_to_log': False, 11:05:19 INFO - 'base_work_dir': '/builds/slave/test', 11:05:19 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:05:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:05:19 INFO - 'branch': 'Fx-Team-Non-PGO', 11:05:19 INFO - 'buildbot_json_path': 'buildprops.json', 11:05:19 INFO - 'config_files': ('talos/linux_config.py',), 11:05:19 INFO - 'default_actions': ('clobber', 11:05:19 INFO - 'read-buildbot-config', 11:05:19 INFO - 'download-and-extract', 11:05:19 INFO - 'populate-webroot', 11:05:19 INFO - 'create-virtualenv', 11:05:19 INFO - 'install', 11:05:19 INFO - 'run-tests'), 11:05:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:05:19 INFO - 'download_minidump_stackwalk': True, 11:05:19 INFO - 'download_symbols': 'ondemand', 11:05:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:05:19 INFO - 'tooltool.py': '/tools/tooltool.py', 11:05:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:05:19 INFO - '/tools/misc-python/virtualenv.py')}, 11:05:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:05:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:05:19 INFO - 'installer_path': 'installer.exe', 11:05:19 INFO - 'log_level': 'info', 11:05:19 INFO - 'log_name': 'talos', 11:05:19 INFO - 'log_to_console': True, 11:05:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:05:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:05:19 INFO - 'opt_config_files': (), 11:05:19 INFO - 'pip_index': False, 11:05:19 INFO - 'sps_profile': False, 11:05:19 INFO - 'sps_profile_interval': 0, 11:05:19 INFO - 'suite': 'dromaeojs', 11:05:19 INFO - 'system_bits': '32', 11:05:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:05:19 INFO - 'title': 'talos-linux64-ix-025', 11:05:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:05:19 INFO - 'use_talos_json': True, 11:05:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:05:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:05:19 INFO - 'work_dir': 'build'} 11:05:19 INFO - ##### 11:05:19 INFO - ##### Running clobber step. 11:05:19 INFO - ##### 11:05:19 INFO - Running pre-action listener: _resource_record_pre_action 11:05:19 INFO - Running main action method: clobber 11:05:19 INFO - rmtree: /builds/slave/test/build 11:05:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:05:20 INFO - Running post-action listener: _resource_record_post_action 11:05:20 INFO - ##### 11:05:20 INFO - ##### Finished clobber step (success) 11:05:20 INFO - ##### 11:05:20 INFO - ##### 11:05:20 INFO - ##### Running read-buildbot-config step. 11:05:20 INFO - ##### 11:05:20 INFO - Running pre-action listener: _resource_record_pre_action 11:05:20 INFO - Running main action method: read_buildbot_config 11:05:20 INFO - Using buildbot properties: 11:05:20 INFO - { 11:05:20 INFO - "project": "", 11:05:20 INFO - "product": "firefox", 11:05:20 INFO - "script_repo_revision": "production", 11:05:20 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:05:20 INFO - "repository": "", 11:05:20 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:05:20 INFO - "buildid": "20160603235926", 11:05:20 INFO - "pgo_build": "False", 11:05:20 INFO - "basedir": "/builds/slave/test", 11:05:20 INFO - "buildnumber": 1816, 11:05:20 INFO - "slavename": "talos-linux64-ix-025", 11:05:20 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:05:20 INFO - "platform": "ubuntu64_hw", 11:05:20 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:05:20 INFO - "branch": "fx-team", 11:05:20 INFO - "repo_path": "integration/fx-team", 11:05:20 INFO - "revision": "c2778bbb1938f995a1e3941c0f3c28c6872893f4", 11:05:20 INFO - "stage_platform": "linux64", 11:05:20 INFO - "builduid": "23468869636e47d1847ad042fc69afbe", 11:05:20 INFO - "slavebuilddir": "test" 11:05:20 INFO - } 11:05:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 11:05:20 INFO - Running post-action listener: _resource_record_post_action 11:05:20 INFO - ##### 11:05:20 INFO - ##### Finished read-buildbot-config step (success) 11:05:20 INFO - ##### 11:05:20 INFO - ##### 11:05:20 INFO - ##### Running download-and-extract step. 11:05:20 INFO - ##### 11:05:20 INFO - Running pre-action listener: _resource_record_pre_action 11:05:20 INFO - Running main action method: download_and_extract 11:05:20 INFO - mkdir: /builds/slave/test/build/tests 11:05: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')]} 11:05:20 INFO - https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:05:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:05:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:05:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:26 INFO - Downloaded 1361 bytes. 11:05:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 11:05:26 INFO - Using the following test package requirements: 11:05:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:05:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:05:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:05:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'jsshell-linux-x86_64.zip'], 11:05:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:05:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 11:05:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:05:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:05:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:05:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 11:05:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:05:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:05:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:26 INFO - https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:05:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:05:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:05:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:28 INFO - Downloaded 22868152 bytes. 11:05:28 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'] 11:05:28 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 11:05:30 INFO - Return code: 0 11:05:30 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 11:05:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:30 INFO - https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:05:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:05:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 11:05:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:31 INFO - Downloaded 22868152 bytes. 11:05:31 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'] 11:05:31 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 11:05:32 INFO - Return code: 0 11:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:32 INFO - https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:05:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:05:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 11:05:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:33 INFO - Downloaded 10833369 bytes. 11:05:33 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'] 11:05:33 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 11:05:33 INFO - Return code: 0 11:05:33 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')]} 11:05:33 INFO - https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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 11:05:35 INFO - Downloaded 55177166 bytes. 11:05:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:05:35 INFO - mkdir: /builds/slave/test/properties 11:05:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:05:35 INFO - Writing to file /builds/slave/test/properties/build_url 11:05:35 INFO - Contents: 11:05:35 INFO - build_url:https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 11:05:35 INFO - Running post-action listener: _resource_record_post_action 11:05:35 INFO - Running post-action listener: set_extra_try_arguments 11:05:35 INFO - ##### 11:05:35 INFO - ##### Finished download-and-extract step (success) 11:05:35 INFO - ##### 11:05:35 INFO - ##### 11:05:35 INFO - ##### Running populate-webroot step. 11:05:35 INFO - ##### 11:05:35 INFO - Running pre-action listener: _resource_record_pre_action 11:05:35 INFO - Running main action method: populate_webroot 11:05:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:05:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:05:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:05:35 INFO - '--tppagecycles', 11:05:35 INFO - '7'], 11:05:35 INFO - 'tests': ['tsvgm']}}, 11:05:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:05:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:05:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:05:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:05:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:05:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['damp', 'tps']}, 11:05:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'tests': ['damp', 'tps']}, 11:05:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['dromaeo_dom']}, 11:05:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:05:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['a11yr', 11:05:35 INFO - 'ts_paint', 11:05:35 INFO - 'tpaint', 11:05:35 INFO - 'sessionrestore', 11:05:35 INFO - 'sessionrestore_no_auto_restore', 11:05:35 INFO - 'tabpaint']}, 11:05:35 INFO - 'other-e10s': {'tests': ['a11yr', 11:05:35 INFO - 'ts_paint', 11:05:35 INFO - 'tpaint', 11:05:35 INFO - 'sessionrestore', 11:05:35 INFO - 'sessionrestore_no_auto_restore', 11:05:35 INFO - 'tabpaint']}, 11:05:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:05:35 INFO - 'ts_paint', 11:05:35 INFO - 'tpaint', 11:05:35 INFO - 'sessionrestore', 11:05:35 INFO - 'sessionrestore_no_auto_restore', 11:05:35 INFO - 'tabpaint']}, 11:05:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:05:35 INFO - 'ts_paint', 11:05:35 INFO - 'tpaint', 11:05:35 INFO - 'sessionrestore', 11:05:35 INFO - 'sessionrestore_no_auto_restore', 11:05:35 INFO - 'tabpaint']}, 11:05:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['a11yr', 11:05:35 INFO - 'ts_paint', 11:05:35 INFO - 'tpaint', 11:05:35 INFO - 'sessionrestore', 11:05:35 INFO - 'sessionrestore_no_auto_restore', 11:05:35 INFO - 'tabpaint']}, 11:05:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['a11yr', 11:05:35 INFO - 'ts_paint', 11:05:35 INFO - 'tpaint', 11:05:35 INFO - 'sessionrestore', 11:05:35 INFO - 'sessionrestore_no_auto_restore', 11:05:35 INFO - 'tabpaint']}, 11:05:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['tsvgx', 11:05:35 INFO - 'tsvgr_opacity', 11:05:35 INFO - 'tart', 11:05:35 INFO - 'tscrollx', 11:05:35 INFO - 'cart']}, 11:05:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:05:35 INFO - 'tsvgr_opacity', 11:05:35 INFO - 'tart', 11:05:35 INFO - 'tscrollx', 11:05:35 INFO - 'cart']}, 11:05:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'talos_options': ['--disable-e10s'], 11:05:35 INFO - 'tests': ['tp5o']}, 11:05:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'tests': ['tp5o']}, 11:05:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'talos_options': ['--disable-e10s', 11:05:35 INFO - '--xperf_path', 11:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:35 INFO - 'tests': ['tp5n']}, 11:05:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:05:35 INFO - 'talos_options': ['--xperf_path', 11:05:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:05:35 INFO - 'tests': ['tp5n']}}, 11:05:35 INFO - 'talos.zip': {'path': '', 11:05:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:05:35 INFO - Running post-action listener: _resource_record_post_action 11:05:35 INFO - ##### 11:05:35 INFO - ##### Finished populate-webroot step (success) 11:05:35 INFO - ##### 11:05:35 INFO - ##### 11:05:35 INFO - ##### Running create-virtualenv step. 11:05:35 INFO - ##### 11:05:35 INFO - Running pre-action listener: _resource_record_pre_action 11:05:35 INFO - Running main action method: create_virtualenv 11:05:35 INFO - Creating virtualenv /builds/slave/test/build/venv 11:05:35 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 11:05:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:05:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:05:36 INFO - Using real prefix '/usr' 11:05:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:05:36 INFO - Installing distribute.............................................................................................................................................................................................done. 11:05:38 INFO - Installing pip.................done. 11:05:38 INFO - Return code: 0 11:05:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:05:38 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')]} 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:38 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')]} 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:38 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:38 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 11:05:38 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 11:05:38 INFO - Using env: {'DISPLAY': ':0', 11:05:38 INFO - 'HOME': '/home/cltbld', 11:05:38 INFO - 'LANG': 'en_US.UTF-8', 11:05:38 INFO - 'LANGUAGE': 'en_US:en', 11:05:38 INFO - 'LOGNAME': 'cltbld', 11:05:38 INFO - 'MAIL': '/var/mail/cltbld', 11:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:38 INFO - 'MOZ_NO_REMOTE': '1', 11:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:38 INFO - 'NO_EM_RESTART': '1', 11:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:38 INFO - 'PWD': '/builds/slave/test', 11:05:38 INFO - 'SHELL': '/bin/bash', 11:05:38 INFO - 'SHLVL': '1', 11:05:38 INFO - 'TERM': 'linux', 11:05:38 INFO - 'TMOUT': '86400', 11:05:38 INFO - 'USER': 'cltbld', 11:05:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:38 INFO - '_': '/tools/buildbot/bin/python'} 11:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:38 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 11:05:38 INFO - Cleaning up... 11:05:38 INFO - Return code: 0 11:05:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:05:38 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')]} 11:05:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:38 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')]} 11:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:38 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:38 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 11:05:38 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 11:05:38 INFO - Using env: {'DISPLAY': ':0', 11:05:38 INFO - 'HOME': '/home/cltbld', 11:05:38 INFO - 'LANG': 'en_US.UTF-8', 11:05:38 INFO - 'LANGUAGE': 'en_US:en', 11:05:38 INFO - 'LOGNAME': 'cltbld', 11:05:38 INFO - 'MAIL': '/var/mail/cltbld', 11:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:38 INFO - 'MOZ_NO_REMOTE': '1', 11:05:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:38 INFO - 'NO_EM_RESTART': '1', 11:05:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:38 INFO - 'PWD': '/builds/slave/test', 11:05:38 INFO - 'SHELL': '/bin/bash', 11:05:38 INFO - 'SHLVL': '1', 11:05:38 INFO - 'TERM': 'linux', 11:05:38 INFO - 'TMOUT': '86400', 11:05:38 INFO - 'USER': 'cltbld', 11:05:38 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:38 INFO - '_': '/tools/buildbot/bin/python'} 11:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:38 INFO - Downloading/unpacking psutil>=3.1.1 11:05:38 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 11:05:38 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 11:05:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:05:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:41 INFO - Installing collected packages: psutil 11:05:41 INFO - Running setup.py install for psutil 11:05:41 INFO - building 'psutil._psutil_linux' extension 11:05:41 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 11:05:41 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 11:05:41 INFO - building 'psutil._psutil_posix' extension 11:05:41 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 11:05:41 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 11:05:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:05:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:05:41 INFO - Successfully installed psutil 11:05:41 INFO - Cleaning up... 11:05:41 INFO - Return code: 0 11:05:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:05:41 INFO - Using env: {'DISPLAY': ':0', 11:05:41 INFO - 'HOME': '/home/cltbld', 11:05:41 INFO - 'LANG': 'en_US.UTF-8', 11:05:41 INFO - 'LANGUAGE': 'en_US:en', 11:05:41 INFO - 'LOGNAME': 'cltbld', 11:05:41 INFO - 'MAIL': '/var/mail/cltbld', 11:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:41 INFO - 'MOZ_NO_REMOTE': '1', 11:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:41 INFO - 'NO_EM_RESTART': '1', 11:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:41 INFO - 'PWD': '/builds/slave/test', 11:05:41 INFO - 'SHELL': '/bin/bash', 11:05:41 INFO - 'SHLVL': '1', 11:05:41 INFO - 'TERM': 'linux', 11:05:41 INFO - 'TMOUT': '86400', 11:05:41 INFO - 'USER': 'cltbld', 11:05:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:41 INFO - '_': '/tools/buildbot/bin/python'} 11:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:05:41 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 11:05:41 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 11:05:41 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 11:05:41 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 11:05:41 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 11:05:41 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 11:05:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:05:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:05:43 INFO - Installing collected packages: mozsystemmonitor 11:05:43 INFO - Running setup.py install for mozsystemmonitor 11:05:43 INFO - Successfully installed mozsystemmonitor 11:05:43 INFO - Cleaning up... 11:05:43 INFO - Return code: 0 11:05:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:05:43 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')]} 11:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:43 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')]} 11:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:43 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:43 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 11:05:43 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 11:05:43 INFO - Using env: {'DISPLAY': ':0', 11:05:43 INFO - 'HOME': '/home/cltbld', 11:05:43 INFO - 'LANG': 'en_US.UTF-8', 11:05:43 INFO - 'LANGUAGE': 'en_US:en', 11:05:43 INFO - 'LOGNAME': 'cltbld', 11:05:43 INFO - 'MAIL': '/var/mail/cltbld', 11:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:43 INFO - 'MOZ_NO_REMOTE': '1', 11:05:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:43 INFO - 'NO_EM_RESTART': '1', 11:05:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:43 INFO - 'PWD': '/builds/slave/test', 11:05:43 INFO - 'SHELL': '/bin/bash', 11:05:43 INFO - 'SHLVL': '1', 11:05:43 INFO - 'TERM': 'linux', 11:05:43 INFO - 'TMOUT': '86400', 11:05:43 INFO - 'USER': 'cltbld', 11:05:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:43 INFO - '_': '/tools/buildbot/bin/python'} 11:05:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:44 INFO - Downloading/unpacking jsonschema==2.5.1 11:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:05:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:05:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:05:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:05:46 INFO - Downloading functools32-3.2.3-2.tar.gz 11:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:05:46 INFO - warning: no files found matching '*.txt' 11:05:46 INFO - no previously-included directories found matching 'build' 11:05:46 INFO - no previously-included directories found matching 'dist' 11:05:46 INFO - no previously-included directories found matching '.git*' 11:05:46 INFO - Installing collected packages: jsonschema, functools32 11:05:46 INFO - Running setup.py install for functools32 11:05:46 INFO - warning: no files found matching '*.txt' 11:05:46 INFO - no previously-included directories found matching 'build' 11:05:46 INFO - no previously-included directories found matching 'dist' 11:05:46 INFO - no previously-included directories found matching '.git*' 11:05:46 INFO - Successfully installed jsonschema functools32 11:05:46 INFO - Cleaning up... 11:05:46 INFO - Return code: 0 11:05:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:46 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:46 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 11:05:46 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 11:05:46 INFO - Using env: {'DISPLAY': ':0', 11:05:46 INFO - 'HOME': '/home/cltbld', 11:05:46 INFO - 'LANG': 'en_US.UTF-8', 11:05:46 INFO - 'LANGUAGE': 'en_US:en', 11:05:46 INFO - 'LOGNAME': 'cltbld', 11:05:46 INFO - 'MAIL': '/var/mail/cltbld', 11:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:46 INFO - 'MOZ_NO_REMOTE': '1', 11:05:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:46 INFO - 'NO_EM_RESTART': '1', 11:05:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:46 INFO - 'PWD': '/builds/slave/test', 11:05:46 INFO - 'SHELL': '/bin/bash', 11:05:46 INFO - 'SHLVL': '1', 11:05:46 INFO - 'TERM': 'linux', 11:05:46 INFO - 'TMOUT': '86400', 11:05:46 INFO - 'USER': 'cltbld', 11:05:46 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:46 INFO - '_': '/tools/buildbot/bin/python'} 11:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:46 INFO - Downloading/unpacking blobuploader==1.2.4 11:05:46 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 11:05:46 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 11:05:46 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 11:05:46 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 11:05:46 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 11:05:46 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 11:05:48 INFO - Downloading blobuploader-1.2.4.tar.gz 11:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:05:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:05:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:48 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 11:05:49 INFO - Downloading docopt-0.6.1.tar.gz 11:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:05:49 INFO - Installing collected packages: blobuploader, requests, docopt 11:05:49 INFO - Running setup.py install for blobuploader 11:05:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:05:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:05:49 INFO - Running setup.py install for requests 11:05:49 INFO - Running setup.py install for docopt 11:05:49 INFO - Successfully installed blobuploader requests docopt 11:05:49 INFO - Cleaning up... 11:05:49 INFO - Return code: 0 11:05:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05: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')]} 11:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05: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')]} 11:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:49 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:49 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 11:05:49 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 11:05:49 INFO - Using env: {'DISPLAY': ':0', 11:05:49 INFO - 'HOME': '/home/cltbld', 11:05:49 INFO - 'LANG': 'en_US.UTF-8', 11:05:49 INFO - 'LANGUAGE': 'en_US:en', 11:05:49 INFO - 'LOGNAME': 'cltbld', 11:05:49 INFO - 'MAIL': '/var/mail/cltbld', 11:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:49 INFO - 'MOZ_NO_REMOTE': '1', 11:05:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:49 INFO - 'NO_EM_RESTART': '1', 11:05:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:49 INFO - 'PWD': '/builds/slave/test', 11:05:49 INFO - 'SHELL': '/bin/bash', 11:05:49 INFO - 'SHLVL': '1', 11:05:49 INFO - 'TERM': 'linux', 11:05:49 INFO - 'TMOUT': '86400', 11:05:49 INFO - 'USER': 'cltbld', 11:05:49 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:49 INFO - '_': '/tools/buildbot/bin/python'} 11:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:50 INFO - Running setup.py (path:/tmp/pip-lOujDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:50 INFO - Running setup.py (path:/tmp/pip-N7IUKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:50 INFO - Running setup.py (path:/tmp/pip-Kz6blO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:50 INFO - Running setup.py (path:/tmp/pip-xN91q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:50 INFO - Running setup.py (path:/tmp/pip-HQ5qso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:50 INFO - Running setup.py (path:/tmp/pip-1OKURu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:50 INFO - Running setup.py (path:/tmp/pip-QTxtHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:50 INFO - Running setup.py (path:/tmp/pip-Iwp3YE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:50 INFO - Running setup.py (path:/tmp/pip-ZNQOrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:50 INFO - Running setup.py (path:/tmp/pip-GoewMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:50 INFO - Running setup.py (path:/tmp/pip-WRc47D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:50 INFO - Running setup.py (path:/tmp/pip-PxJYBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:50 INFO - Running setup.py (path:/tmp/pip-2ufYfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:51 INFO - Running setup.py (path:/tmp/pip-kkBOpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:51 INFO - Running setup.py (path:/tmp/pip-6q0Ios-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:51 INFO - Running setup.py (path:/tmp/pip-AIjSvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:51 INFO - Running setup.py (path:/tmp/pip-CpuQML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:05:51 INFO - Running setup.py install for manifestparser 11:05:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:05:51 INFO - Running setup.py install for mozcrash 11:05:51 INFO - Running setup.py install for mozdebug 11:05:51 INFO - Running setup.py install for mozdevice 11:05:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:05:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:05:51 INFO - Running setup.py install for mozfile 11:05:51 INFO - Running setup.py install for mozhttpd 11:05:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:05:51 INFO - Running setup.py install for mozinfo 11:05:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Running setup.py install for mozInstall 11:05:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Running setup.py install for mozleak 11:05:52 INFO - Running setup.py install for mozlog 11:05:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Running setup.py install for moznetwork 11:05:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Running setup.py install for mozprocess 11:05:52 INFO - Running setup.py install for mozprofile 11:05:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Running setup.py install for mozrunner 11:05:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:05:52 INFO - Running setup.py install for mozscreenshot 11:05:52 INFO - Running setup.py install for moztest 11:05:52 INFO - Running setup.py install for mozversion 11:05:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:05:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:05:53 INFO - Cleaning up... 11:05:53 INFO - Return code: 0 11:05:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:53 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')]} 11:05:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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')]} 11:05:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:53 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:53 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 11:05:53 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 11:05:53 INFO - Using env: {'DISPLAY': ':0', 11:05:53 INFO - 'HOME': '/home/cltbld', 11:05:53 INFO - 'LANG': 'en_US.UTF-8', 11:05:53 INFO - 'LANGUAGE': 'en_US:en', 11:05:53 INFO - 'LOGNAME': 'cltbld', 11:05:53 INFO - 'MAIL': '/var/mail/cltbld', 11:05:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:53 INFO - 'MOZ_NO_REMOTE': '1', 11:05:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:53 INFO - 'NO_EM_RESTART': '1', 11:05:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:53 INFO - 'PWD': '/builds/slave/test', 11:05:53 INFO - 'SHELL': '/bin/bash', 11:05:53 INFO - 'SHLVL': '1', 11:05:53 INFO - 'TERM': 'linux', 11:05:53 INFO - 'TMOUT': '86400', 11:05:53 INFO - 'USER': 'cltbld', 11:05:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:53 INFO - '_': '/tools/buildbot/bin/python'} 11:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:05:53 INFO - Running setup.py (path:/tmp/pip-qeaK1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:05:53 INFO - Running setup.py (path:/tmp/pip-yccrdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:05:53 INFO - Running setup.py (path:/tmp/pip-aS0VDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:05:53 INFO - Running setup.py (path:/tmp/pip-HkCGVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:05:53 INFO - Running setup.py (path:/tmp/pip-h6223w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:05:53 INFO - Running setup.py (path:/tmp/pip-WgDVE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:05:53 INFO - Running setup.py (path:/tmp/pip-lzYuRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:05:53 INFO - Running setup.py (path:/tmp/pip-LyWUGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:05:53 INFO - Running setup.py (path:/tmp/pip-gusmIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:05:53 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)) 11:05:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:05:53 INFO - Running setup.py (path:/tmp/pip-Jb3qdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:05:54 INFO - Running setup.py (path:/tmp/pip-rasMua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:05:54 INFO - Running setup.py (path:/tmp/pip-oGIGWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:05:54 INFO - Running setup.py (path:/tmp/pip-I9P7kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:05:54 INFO - Running setup.py (path:/tmp/pip-EgSvL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:54 INFO - Running setup.py (path:/tmp/pip-mS0_Hb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:05:54 INFO - Running setup.py (path:/tmp/pip-zNF3Sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:05:54 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)) 11:05:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:05:54 INFO - Running setup.py (path:/tmp/pip-QnlJuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:05:54 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)) 11:05:54 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)) 11:05:54 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)) 11:05:54 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)) 11:05:54 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)) 11:05:54 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)) 11:05:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:05:54 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 11:05:54 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 11:05:54 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 11:05:54 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 11:05:54 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 11:05:54 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 11:05:56 INFO - Downloading blessings-1.6.tar.gz 11:05:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:05:56 INFO - Installing collected packages: blessings 11:05:56 INFO - Running setup.py install for blessings 11:05:56 INFO - Successfully installed blessings 11:05:56 INFO - Cleaning up... 11:05:56 INFO - Return code: 0 11:05:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:05:56 INFO - Reading from file tmpfile_stdout 11:05:56 INFO - Current package versions: 11:05:56 INFO - argparse == 1.2.1 11:05:56 INFO - blessings == 1.6 11:05:56 INFO - blobuploader == 1.2.4 11:05:56 INFO - docopt == 0.6.1 11:05:56 INFO - functools32 == 3.2.3-2 11:05:56 INFO - jsonschema == 2.5.1 11:05:56 INFO - manifestparser == 1.1 11:05:56 INFO - mozInstall == 1.12 11:05:56 INFO - mozcrash == 0.17 11:05:56 INFO - mozdebug == 0.1 11:05:56 INFO - mozdevice == 0.48 11:05:56 INFO - mozfile == 1.2 11:05:56 INFO - mozhttpd == 0.7 11:05:56 INFO - mozinfo == 0.9 11:05:56 INFO - mozleak == 0.1 11:05:56 INFO - mozlog == 3.2 11:05:56 INFO - moznetwork == 0.27 11:05:56 INFO - mozprocess == 0.22 11:05:56 INFO - mozprofile == 0.28 11:05:56 INFO - mozrunner == 6.11 11:05:56 INFO - mozscreenshot == 0.1 11:05:56 INFO - mozsystemmonitor == 0.3 11:05:56 INFO - moztest == 0.7 11:05:56 INFO - mozversion == 1.4 11:05:56 INFO - psutil == 3.1.1 11:05:56 INFO - requests == 1.2.3 11:05:56 INFO - wsgiref == 0.1.2 11:05:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:56 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:56 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 11:05:56 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 11:05:56 INFO - Using env: {'DISPLAY': ':0', 11:05:56 INFO - 'HOME': '/home/cltbld', 11:05:56 INFO - 'LANG': 'en_US.UTF-8', 11:05:56 INFO - 'LANGUAGE': 'en_US:en', 11:05:56 INFO - 'LOGNAME': 'cltbld', 11:05:56 INFO - 'MAIL': '/var/mail/cltbld', 11:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:56 INFO - 'MOZ_NO_REMOTE': '1', 11:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:56 INFO - 'NO_EM_RESTART': '1', 11:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:56 INFO - 'PWD': '/builds/slave/test', 11:05:56 INFO - 'SHELL': '/bin/bash', 11:05:56 INFO - 'SHLVL': '1', 11:05:56 INFO - 'TERM': 'linux', 11:05:56 INFO - 'TMOUT': '86400', 11:05:56 INFO - 'USER': 'cltbld', 11:05:56 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:56 INFO - '_': '/tools/buildbot/bin/python'} 11:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 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)) 11:05:57 INFO - Cleaning up... 11:05:57 INFO - Return code: 0 11:05:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:57 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:57 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 11:05:57 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 11:05:57 INFO - Using env: {'DISPLAY': ':0', 11:05:57 INFO - 'HOME': '/home/cltbld', 11:05:57 INFO - 'LANG': 'en_US.UTF-8', 11:05:57 INFO - 'LANGUAGE': 'en_US:en', 11:05:57 INFO - 'LOGNAME': 'cltbld', 11:05:57 INFO - 'MAIL': '/var/mail/cltbld', 11:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:57 INFO - 'MOZ_NO_REMOTE': '1', 11:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:57 INFO - 'NO_EM_RESTART': '1', 11:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:57 INFO - 'PWD': '/builds/slave/test', 11:05:57 INFO - 'SHELL': '/bin/bash', 11:05:57 INFO - 'SHLVL': '1', 11:05:57 INFO - 'TERM': 'linux', 11:05:57 INFO - 'TMOUT': '86400', 11:05:57 INFO - 'USER': 'cltbld', 11:05:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:57 INFO - '_': '/tools/buildbot/bin/python'} 11:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:05:57 INFO - Cleaning up... 11:05:57 INFO - Return code: 0 11:05:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:05:57 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 0x7f4ea3999f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e338a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efe350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, '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': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', '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 11:05:57 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 11:05:57 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 11:05:57 INFO - Using env: {'DISPLAY': ':0', 11:05:57 INFO - 'HOME': '/home/cltbld', 11:05:57 INFO - 'LANG': 'en_US.UTF-8', 11:05:57 INFO - 'LANGUAGE': 'en_US:en', 11:05:57 INFO - 'LOGNAME': 'cltbld', 11:05:57 INFO - 'MAIL': '/var/mail/cltbld', 11:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:05:57 INFO - 'MOZ_NO_REMOTE': '1', 11:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:05:57 INFO - 'NO_EM_RESTART': '1', 11:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:05:57 INFO - 'PWD': '/builds/slave/test', 11:05:57 INFO - 'SHELL': '/bin/bash', 11:05:57 INFO - 'SHLVL': '1', 11:05:57 INFO - 'TERM': 'linux', 11:05:57 INFO - 'TMOUT': '86400', 11:05:57 INFO - 'USER': 'cltbld', 11:05:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:05:57 INFO - '_': '/tools/buildbot/bin/python'} 11:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:05:57 INFO - Downloading/unpacking flake8 11:05:57 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 11:05:57 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 11:05:57 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 11:05:57 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 11:05:57 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 11:05:57 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 11:05:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:05:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:05:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:05:59 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 11:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:06:00 INFO - no previously-included directories found matching 'docs/_build' 11:06:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:06:00 INFO - Running setup.py install for pep8 11:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:06:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:06:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:06:00 INFO - no previously-included directories found matching 'docs/_build' 11:06:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:06:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:06:00 INFO - Cleaning up... 11:06:00 INFO - Return code: 0 11:06:00 INFO - Running post-action listener: _resource_record_post_action 11:06:00 INFO - Running post-action listener: _start_resource_monitoring 11:06:00 INFO - Starting resource monitoring. 11:06:00 INFO - ##### 11:06:00 INFO - ##### Finished create-virtualenv step (success) 11:06:00 INFO - ##### 11:06:00 INFO - ##### 11:06:00 INFO - ##### Running install step. 11:06:00 INFO - ##### 11:06:00 INFO - Running pre-action listener: _resource_record_pre_action 11:06:00 INFO - Running main action method: install 11:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:06:00 INFO - Reading from file tmpfile_stdout 11:06:00 INFO - Detecting whether we're running mozinstall >=1.0... 11:06:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:06:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:06:00 INFO - Reading from file tmpfile_stdout 11:06:00 INFO - Output received: 11:06:00 INFO - Usage: mozinstall [options] installer 11:06:00 INFO - Options: 11:06:00 INFO - -h, --help show this help message and exit 11:06:00 INFO - -d DEST, --destination=DEST 11:06:00 INFO - Directory to install application into. [default: 11:06:00 INFO - "/builds/slave/test"] 11:06:00 INFO - --app=APP Application being installed. [default: firefox] 11:06:00 INFO - mkdir: /builds/slave/test/build/application 11:06:00 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'] 11:06:00 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 11:06:16 INFO - Reading from file tmpfile_stdout 11:06:16 INFO - Output received: 11:06:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:06:16 INFO - Running post-action listener: _resource_record_post_action 11:06:16 INFO - ##### 11:06:16 INFO - ##### Finished install step (success) 11:06:16 INFO - ##### 11:06:16 INFO - ##### 11:06:16 INFO - ##### Running run-tests step. 11:06:16 INFO - ##### 11:06:16 INFO - Running pre-action listener: _resource_record_pre_action 11:06:16 INFO - Running main action method: run_tests 11:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:06:16 INFO - Python 2.7.3 11:06:16 INFO - Return code: 0 11:06:16 INFO - grabbing minidump binary from tooltool 11:06:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:06:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f8d1c0>, '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 0x1f8e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f8e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:06:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:06:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:06:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:06:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:06:16 INFO - Return code: 0 11:06:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:06:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:06:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:06:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:06:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:06:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:06:17 INFO - Return code: 0 11:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 11:06:17 INFO - Using env: {'DISPLAY': ':0', 11:06:17 INFO - 'HOME': '/home/cltbld', 11:06:17 INFO - 'LANG': 'en_US.UTF-8', 11:06:17 INFO - 'LANGUAGE': 'en_US:en', 11:06:17 INFO - 'LOGNAME': 'cltbld', 11:06:17 INFO - 'MAIL': '/var/mail/cltbld', 11:06:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:06:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:06:17 INFO - 'MOZ_NO_REMOTE': '1', 11:06:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:06:17 INFO - 'NO_EM_RESTART': '1', 11:06:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:06:17 INFO - 'PWD': '/builds/slave/test', 11:06:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:06:17 INFO - 'SHELL': '/bin/bash', 11:06:17 INFO - 'SHLVL': '1', 11:06:17 INFO - 'TERM': 'linux', 11:06:17 INFO - 'TMOUT': '86400', 11:06:17 INFO - 'USER': 'cltbld', 11:06:17 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274', 11:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:06:17 INFO - '_': '/tools/buildbot/bin/python'} 11:06:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 11:06:17 INFO - mozversion application_buildid: 20160603235926 11:06:17 INFO - mozversion application_changeset: c2778bbb1938f995a1e3941c0f3c28c6872893f4 11:06:17 INFO - mozversion application_display_name: Nightly 11:06:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:06:17 INFO - mozversion application_name: Firefox 11:06:17 INFO - mozversion application_remotingname: firefox 11:06:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:06:17 INFO - mozversion application_vendor: Mozilla 11:06:17 INFO - mozversion application_version: 49.0a1 11:06:17 INFO - mozversion platform_buildid: 20160603235926 11:06:17 INFO - mozversion platform_changeset: c2778bbb1938f995a1e3941c0f3c28c6872893f4 11:06:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:06:17 INFO - mozversion platform_version: 49.0a1 11:06:17 INFO - using testdate: 1465063577 11:06:17 INFO - actual date: 1465063577 11:06:17 INFO - starting webserver on 'localhost:47217' 11:06:17 INFO - SUITE-START | Running 2 tests 11:06:17 INFO - TEST-START | dromaeo_css 11:06:17 INFO - operating with platform_type : linux_ 11:06:17 INFO - Initialising browser for dromaeo_css test... 11:06:17 INFO - TEST-INFO | started process 4075 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoI4F_/profile http://localhost:47217/getInfo.html) 11:06:22 INFO - PROCESS | 4075 | __metrics Screen width/height:1600/1200 11:06:22 INFO - PROCESS | 4075 | colorDepth:24 11:06:22 INFO - PROCESS | 4075 | Browser inner width/height: 1024/697 11:06:22 INFO - PROCESS | 4075 | __metrics 11:06:23 ERROR - PROCESS | 4075 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:06:24 INFO - TEST-INFO | 4075: exit 0 11:06:24 INFO - Browser initialized. 11:06:24 INFO - Running cycle 1/1 for dromaeo_css test... 11:06:24 INFO - TEST-INFO | started process 4154 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsoI4F_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:06:36 INFO - PROCESS | 4154 | RSS: Main: 157630464 11:06:36 INFO - PROCESS | 4154 | 11:07:27 INFO - PROCESS | 4154 | 1465063647717 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] 11:09:39 INFO - PROCESS | 4154 | Cycle 1(1): loaded http://localhost:47217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47217/tests/dromaeo/cssquery-ext.html) 11:09:40 INFO - PROCESS | 4154 | RSS: Main: 253095936 11:09:40 INFO - PROCESS | 4154 | 11:12:43 INFO - PROCESS | 4154 | Cycle 1(1): loaded http://localhost:47217/tests/dromaeo/cssquery-ext.html (next: http://localhost:47217/tests/dromaeo/cssquery-jquery.html) 11:12:43 INFO - PROCESS | 4154 | RSS: Main: 238940160 11:12:43 INFO - PROCESS | 4154 | 11:15:45 INFO - PROCESS | 4154 | Cycle 1(1): loaded http://localhost:47217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47217/tests/dromaeo/cssquery-mootools.html) 11:15:46 INFO - PROCESS | 4154 | RSS: Main: 245080064 11:15:46 INFO - PROCESS | 4154 | 11:18:48 INFO - PROCESS | 4154 | Cycle 1(1): loaded http://localhost:47217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47217/tests/dromaeo/cssquery-prototype.html) 11:18:49 INFO - PROCESS | 4154 | RSS: Main: 245288960 11:18:49 INFO - PROCESS | 4154 | 11:21:52 INFO - PROCESS | 4154 | Cycle 1(1): loaded http://localhost:47217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47217/tests/dromaeo/cssquery-yui.html) 11:21:53 INFO - PROCESS | 4154 | RSS: Main: 212049920 11:21:53 INFO - PROCESS | 4154 | 11:24:55 INFO - PROCESS | 4154 | Cycle 1(1): loaded http://localhost:47217/tests/dromaeo/cssquery-yui.html (next: http://localhost:47217/tests/dromaeo/cssquery-dojo.html) 11:24:56 INFO - PROCESS | 4154 | RSS: Main: 273305600 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | __start_tp_report 11:24:56 INFO - PROCESS | 4154 | _x_x_mozilla_page_load 11:24:56 INFO - PROCESS | 4154 | _x_x_mozilla_page_load_details 11:24:56 INFO - PROCESS | 4154 | |i|pagename|runs| 11:24:56 INFO - PROCESS | 4154 | |0;dojo.html;2685.4226341336616;2689.932751681209;2715.3203120324;2726.4819684259987;2752.8485933273673;4495.820167193308;4588.678792484528;4679.251319788835;4741.620670346377;4823.951760482394;4681.368015317931;4683.531646835315;4696.201645720227;4719.315699223611;4728.66899317048;4111.814968326433;4248.468941382335;4340.609345158935;4364.258076127066;4492.10157968406;4396.582324679151;4434.312681534368;4449.822007119711;4458.4426946631675;4476.843310484133;4274;4298.31227003681;4333.544977777351;4363.410939523155;4368.322909948947;4325.178216138924;4331.956680433187;4333.046729719456;4436.290193569013;4451.5103338632725;4356.978215108936;4360.149770794696;4383.320585309282;4407.713498622579;4408.3607876858;4419.668524860648;4536.228841097021;4617.215073437524;4642.442906851199;4724.5984091352275;5052.570531504826;5065.518775716301;5070.645054846163;5073.112205364084;5080.898382032376;5076.898462030738;5109.182530795055;5111.258867464197;5113.897722045538;5118.769655365518;4649.418822647169;4705.505921878222;4707.317438971399;4741.407324084489;4774.546418090275;5229.50319719626;5241.292425522505;5250.737463126905;5255;5255.39562950258;5004.949950500449;5051.646384753106;5054.469280725544;5055.064813009605;5057.140286151363;4947.282644016597;4991.625628077909;5074.5179207975925;5076.44159142494;5142.922856157161;5030.974845125824;5032.597392208614;5036.043151801146;5036.294918711384;5049.5707864831165;5013.849584512471;5022.146235140035;5022.296878437021;5024.271480635361;5068.873278168076;4178.603032711888;4217.894552636148;4222;4281.357796330575;4312.331588603772;3755.4742336072973;3771.2080463102507;3781.7920014399474;3792.6965842732516;3825.311443940062;4399.076193999232;4407.184670835905;4419.955800442019;4446.244138496463;4464.196444639931;4921.803127874845;5148.9742551287;5193.3767947845745;5212.166053431509;5255.710935898563;4250.277452833026;4319.222539942841;4349.391085248068;4355.1725172217175;4370;4572.977135114304;4573.359729637853;4575.542445755398;4575.931361029588;4619.19164146273;4665.066986602626;4709.1994360958715;4790.520947905182;4797.184478638709;4844.612431005511;5023.196288593807;5098.337216161875;5148.30497882781;5159.845204643867;5167.379914410295;4824.8793780155775;4825.083234185494;4834.806607735652;4844.781984810763;4891.021795640815;4909;5061.670991385548;5065.696058236517;5067.746612669425;5128.923066153936;5001.449840517613;5028.245763135559;5050.898982020412;5112.054269960069;5117.1300878851425;4927.728974906415;4933.654644174873;4938.678985865908;4942.406911170682;4977.800887964586;4932.21084626458;4935.876603084952;4944.579710724629;4945.579625731853;4981.103401387785;4728.881777955441;4821.686590371614;4838.782254798472;4843.321934929042;4881.658283920092;5007;5028.723420211923;5039.974800125976;5053.191489361684;5076.263941728354;4654.953450465452;4806.327114203944;4858.878528036827;4866;4917.754112294299 11:24:56 INFO - PROCESS | 4154 | |1;ext.html;549.914763211702;589.9026660601002;589.911513273009;590.4597293476467;606.372404561279;27508;28043.579346309823;30219.848900755493;39701.60298397015;41212.79393603035;41402.79298603503;41872.162556748845;41878.371824422655;42002.159956800846;42020.789896050555;7723.72966946157;7892.723754668587;7893.092294386133;7896.328812050982;7902.367810575169;7677.078750549942;7751.147373788879;7812.414068944823;7815.687372505093;7818;7851.057873055212;7895.605219739019;7897.170797066312;7898.644560994769;7899.565523896184;7786.260305271018;7826.413019023567;7827.25641064098;7831.921680783234;7835.255650713173;7749.728759493447;7809.3752499799875;7810.726624568169;7812.921870781276;7817.804554886116;38604;39068.21863562741;39080.21839563193;39084.41373379402;39116;2929.326254961371;2962.4963756161505;3303.96696033039;3698.85204591816;3762.5108735864164;27545.586816197574;29618.70381296181;29893.252668683457;29997.550036749468;31017.534736978963;3413.2149605590603;3427.1774774054297;3475;3495.790252584853;3549.3078849624335;245794;245821;246412;246664.9999999982;247052;55784;56043.43956560464;56057.71971140118;56072;56138.43861561332;49783.751081244365;51581;55929.161062583276;58087.41912580904;58276.125858112166;14451;14451.277436128361;14556.927215364067;14572.854271457361;14577.052491588012;11166.994970452699;11258.887411125948;11367.54529818798;11441.828372574419;11464.025557827512;15822.367105315889;16157.67684646324;16164.434244801376;16918.492445226664;17862.55343616394;6569;6797.694103765342;6871.484638652021;7032.753853615099;7158.8210294742;828.8590939540293;951.2390087929629;972.4214092614883;974.2741657465234;980.6175591519313;26395.868020659775;27399.452010960067;27683.169504914884;27799.722002779712;27890.72109278922;1009.4548943570389;1012.2559918459926;1047.5966752800227;1051.0989668514953;1103.7406209540752;14576.635584110481;14773.556793296219;14853.10881347101;15023.248837558078;15193.62015949588;366704.16647917125;368909;369914;371639;372498;49709.25436118461;50348.748256258485;50506;50615;50628.74685626622;1189.9144292934857;1198.8501437320335;1199.9580014699618;1201.5133870782347;1240.0327744359415;26489.205323840317;27644.723552764215;27777.583336250376;28140.71859281463;28183.859080704464;42832.57167428286;42932.35601466043;42963;43108.353374698774;43317.35023974706;314072;314639;315203;315489;317260;21353;22250.554988900454;22833.20083797059;25735.485290294462;26186.214413567624;38358.42462363011;42020;42076.36885446782;42168.15663686648;42669.78665106655;35525.28949420946;36392.454113188855;36493.45259821052;36678.63321366859;36918.63081369152;35286.823565882005;35456.82271588626;35491.33751887418;35775.82112089423;35996;35431.82284088563;36199;36416.63583364239;36421.45367819432;36694.8165259172;31891.6810831898;32125.03624891257;32513;32551.18622034468;32668.183295417806;23979.880100599385;24195.63706544368;24423.270555674215;24441.51116977686;24455.75544244606 11:24:56 INFO - PROCESS | 4154 | |2;jquery.html;363.9290338384016;367.61767761528006;368.46756436948584;371.23896013173;384.5423945504849;16542.338306467744;16686.249118789652;16860.83139168608;17077.23152458139;17122.486325410227;15080.867042498277;15504.379824806994;15713.371465141381;15733.60665983351;15962.680746385066;4963.677360971535;5079.568236699885;5134.486551344854;5162.586993040548;5167.767450464738;3695.5750088739737;3863.864764733235;5055.823046193384;5580.748866301006;5900.1739756434135;5947.464728174464;5957.374475680034;5974.55190860685;5975.462208401243;5977.163197152402;5765.798197063083;5871.324797648261;5909.349971503131;5915.290165180184;5922.703864806743;3341.849616767227;4850.102730994778;5172.250023746536;5178.378594568639;5182.274481572583;19834.206631734713;20453.181872725072;20563.691544626843;20667.89666051675;20681.68977465339;1846.5752876838403;2005.4986253436641;2271.7728227177317;2280.905165520543;2488.390344365624;12653;12850.614481565475;12981.221126732426;13004;13441.66395840102;1685.8651307895461;1746.9912650436793;1762.1013283225648;1779.9377021804175;1814.1564172659776;62893.37106628921;64065.3593464064;65334;65895.99999999952;66330;9390.953045234866;9513.238940884712;9633.229341652652;10015.849762253572;10121.24090693201;13422.932885335511;13485.595432137052;13489.932550337186;13512.121712088683;13513.986451016213;6969.4424446044195;7029.191642961023;7072.469564782662;7098.751543695946;7120.323569260912;6496.707648155844;6630.867382652416;6673.366030227217;6696.531242812956;6735.225449073321;5924.11138329254;6202.844928876814;6219.0982307566055;6247.156633854463;6342.048692696132;1522.454708470903;1669.8394615742186;1714.9399771008204;1736.5398169485097;1739.052261467165;820.526113766993;851.8892543969245;917.2249449215402;942.472215559289;1008.5511947183433;16020.359185632677;16558.503244902433;16768.916155419145;16858.325666973185;17189.31242750301;916.7249825052457;917.4266083697689;924.0574613893925;959.3476436023572;981.8379967305458;9092.727218183465;9913.355631883904;9932.453715045598;10192.745181370525;10323.48382580868;364071;364767;365074;367754;369008;49398.753006235456;54489;78040.60979695065;78866.60566697245;79413;930.5161316115717;941.8493041113389;953.909378609031;961.9711408657612;964.7588102974116;15752;15811.920940395685;15838.366465341258;15997.280122394288;16311.429099981444;34549.48175777315;35150.824245878604;35576.28847423089;36114.27771444504;36631.633683662825;46292.30561541512;48162.27756583724;49382;49503.50496495133;49953;7740.961295193488;7780.961095194488;7789.376849851885;7843.686252550062;7908.960455197687;10957.83563246568;11395.373254471084;11635.650930472098;11638.53445862156;11939.283642981449;5076.619253555924;9565.617375305188;9705.661885962834;9938.850917236103;10281.691549253534;9923.553440095357;9959.551820167964;10038.297319187586;10074.244431667508;10185.796284074426;9923.55344009507;10180.490975451346;10255.128314093387;10428.634997775041;10679.626213082505;7675.769726908202;7683.538987660758;7759.650815713419;7797.688092476237;7906.090799557895;9164.495952722664;9860.211183105477;9861.457619830979;9921.55353009102;9981.401115933068 11:24:56 INFO - PROCESS | 4154 | |3;mootools.html;1223.5962132496277;1389.8888088952885;1440.3950340856838;1513.273628658244;1759.7184450487925;6377.61734295942;7358.448116391272;7633.084029916417;7634.58009809461;7872.645730942107;7595.240475952416;7728.033995750531;7731.806704832382;7740.419468539854;7740.574268415235;1828.945131646046;2030.2792508659434;2071.1715313874497;2094.89525523724;2123.8725676459385;2142.967855482169;2161.275972549198;2161.4056134562966;2164.361513353557;2166.393409845246;2037.9796202037937;2059.166037754704;2071.6996035574834;2073.8340932725423;2074.636938535758;1751.290727255457;2004.7494063242095;2035.745531808524;2040.2451093095501;2069.0689189864547;2077.6156411064003;2077.8337732981477;2096.381567437594;2098.9790102098937;2099.1603358656507;7631.465797394185;7697.846043079107;7698.653560589787;7706.152323244439;7708.768736937901;4326.697131200817;4459.576340247671;4460.553944605514;4460.907077765935;4467.128909862578;2774.153883065664;2934.8092373995623;2941.2793865502877;2945.3520225550346;2949.941001179986;846;855.7261676263598;890.0520945193348;909.0999910088964;923.607466826596;10488.213383996155;10496.790064198673;10527.578896844117;10527.84208236877;10528.36829790215;3992.5608183099835;4127.29835927893;4206.537280899099;4210.157968406331;4210.473690788652;8999.640014399482;9046.86429703555;9068.81862362749;9077.591508382138;9080.40977336471;4440.755758433317;4450.043240703199;4450.1767173073085;4451.977740111279;4462.41988541494;3496.5454490916018;3922.607739226112;4041.0503531670033;4060.147369052532;4121.814518346681;3562.3587754203973;3564.6078931317534;3684.097396137963;3734.533183352081;3762.529683789526;1158.2760774515928;1190.7737529869298;1192.7197108679454;1192.7256730951929;1193.0455635491746;833.9159093178844;836.5608055770768;840.3781201910542;856.1181982557976;860.4966094834467;5005.499450055038;5095.541401273903;5235.267062611238;5319.2021196820015;5332.626716129911;888.3337496877342;906.211595911548;914.794171311463;916.7295647783919;924.856647219682;3451.2062225688233;3584.8386822593047;3605.4772058051435;3632.9636703632627;3648.3615367310613;9066.773330666787;9225.677101301422;9425.764355891157;9442.811143777086;9500.097490738368;9221.077892210726;9315.906840931639;9390.765230869283;9396.295277854051;9417.482038487811;7129.750458734024;7272.381847543018;7281.834906414948;7291.34377905991;7292.781216563618;5383.838484845461;5391.86520336979;5543.556515478833;5607.130894711327;5636.830895072991;8281.875771863548;8525.786855328666;8529.95735021321;8530.872036919576;8541.103184165573;8303.377246706643;8465.57672116404;8526.872096918427;8652.697155599524;8679.045305016316;5892.145638882424;6072.817815465543;6072.939270607414;6477.8704425912165;6656.2345330287635;6170.876582468415;7248.130224373109;7266.96366518164;7435.628218589157;7455.329020388191;6465.482761379172;6550.6069635822005;6691.866162676816;6746.089277947414;6815.965920170367;6476.093346931528;6520.18497687789;6530.934690653033;6620.735170593122;6675.566088204251;6349.428551430394;6367.490600752021;6408.198975128109;6427.967860160669;6433.131527243762;4547.477040140427;4587.839425620087;4634.513376095596;4639.095376401569;4714.787834547385;4580.793864276049;4667.369905062773;4673.462551806586;4704.764761761967;4741.312509686145 11:24:56 INFO - PROCESS | 4154 | |4;prototype.html;290.84439824693794;292.2139444893237;295.25153735281066;295.7855554722825;299.49684529989617;4753.3820603321565;4764.546813221966;4766.475687674353;4797.640176986727;4806.423229212491;4726.881827954303;4737.242041273397;4752.16837053516;4759.904801903968;4759.928601070987;3541.4333706607013;3588.5155504006884;3664.8167591620445;3688.6311368863167;3746.6815320697774;3691.6123807000145;3704.2406306707194;3712.851485940559;3742.6257374262627;3749.756265842725;3693.1874987502706;3701.167237371597;3710.4805327254207;3736;3745.1198968242443;3534.4344904815234;3612.151144481045;3702.907427314312;3708.6662200401825;3728.086618778417;3246.9188270293193;3257.364813861298;3276.885309014197;3279.1310302769784;3282.720968717662;4521.276595744665;4527.977360113211;4565.657575681837;4590;4590.816367345302;3964.682825373963;4170.52039015514;4257.850975215883;4270.765107919063;4275.4228179195725;4888.9755551222015;4912.828051018233;4953.23224900141;4960.23116416956;4962.702237865704;3469.271452994874;3470.201853573692;3477.2523907360037;3495.6853883150384;3516.3670539302916;5018.899622007576;5179.290834024763;5250.44870288618;5257.5005374489365;5270.578353731692;3502.877399291013;3522.7534072615185;3533.5229743984746;3535.1338921964284;3542.415501442233;3537.02731748766;3562.6437356264164;3574.857005719794;3586.9103272418397;3592.479090531858;4132.772697501606;4134.3178375568295;4138.606832350922;4144.274751918402;4153.169366126786;4649;4931.654784165074;4958.454569997298;4975.402951645826;4980.800767969241;1240.3550153920091;1243.4839541590138;1247.2267194339386;1250.9624711258496;1253.348258905364;794.1343935110757;796.3947399975945;802.5064585280011;817.3461231015164;825.9504429734235;4249.723767955073;4395.978020109879;4404.625606823456;4414.249577571821;4417.889552761207;5078.3905931287745;5092.439831618519;5118.641695081383;5122.590192784568;5133.717645529532;4391;4403.185410699031;4421.469423669116;4421.867343979686;4426.313921342197;2575.3046677396997;2719.73532307478;2723.577845433961;2725.523033469135;2725.713800051006;4824.782884770194;4851.175300198975;4866.683665561727;4868.537488938545;4879.536444037882;5086.21163719624;5223.373195216523;5265;5265.868353291198;5299.708516031578;4886.584640305614;4888.780004899788;4895.7062576245535;4898.187670561915;4900.117978763857;5104.515071068243;5113.4375218726655;5115.053715062725;5166.509181627739;5174.111449320895;4778.37881075458;4992.375953005874;5026.296318515338;5050.141475949171;5066.898662026812;4836.298736683231;4842.4189097308545;4859.562639362474;4861.392325959255;4865.58642515376;3560.2701446203982;3565.607783143904;3574.9642503574632;3587.443946188345;3595.9280814384088;4899.926501102415;5153.3558305211845;5156.484351564814;5161.432242453252;5200.531952124327;4907.779149938333;4925.408950925912;4940.851774446773;4943.5797957174045;4953.182724850503;4920.72935988524;4945.876353091202;4948.208286674115;4965.875853103701;4966.8758281043265;4599.264117741145;4791.616670666408;4807.375041244616;4846.781894814812;4852.223644216909;4712.246040633482;4858.46556878736;4958.380202474691;4997.350344455198;5006.1739812930455;4839.249916262985;4864.513548645107;4867.5132486751045;4870.732109733999;4884.584810291165 11:24:56 INFO - PROCESS | 4154 | |5;yui.html;639.9488040956724;653.7940548727148;678.7827895073575;715.9785206443806;719.2807192807193;11411.714707132325;12025.338606376647;12280.385980700963;12333.198342107768;12691.11162218645;12947.741045179091;13028.73942521149;13140.14589051711;13146.737065258689;13147.868521314784;633.7148283272546;780.9921900781005;791.6714563456159;801.374927556504;802.3741481644327;796.0964305513227;802.3100133884855;802.574635443216;803.1526739290047;804.2078552625659;841.877927700483;849.4096602861014;851.4380508864151;851.5827244650108;852.5524099847598;656;811.930985866202;830.9459885107449;843.5360551696573;848.70295396611;607.9574429789916;608.0544752909225;609.3388673289486;609.7743834781115;610.1579819848625;12564.937175314066;12593.244405335709;12638.431270592846;12676.492940282378;12682.112252142353;12341.568045118378;12369.381530923418;12884.355782210945;12898.87101128986;13062.673433164247;11323.660290191307;11503.367314797682;11598.652040438801;11611.710139740226;12078.758424831454;3234.094453552985;4102.835886564534;4222.641075508585;4227.767472788995;4256.44666193396;62373.37626623766;63585.68207158981;63768.68115659392;63792;63820.361796381905;10530;10651.786964260671;10752.301100428447;10889.618863339745;11092.778144437067;20214;20306.593868122556;20904;20913.05891234898;20946.79053209479;6584.8024559263295;6671.833204169838;6712.731490740413;6714.01032771001;6913.066735990677;3734.3838266686234;3763.7741735495956;3782.829772660237;3828.157805282833;3854.9229015419533;2818.070036887822;2903.970960290412;2905.1429828200307;2906.0264811288034;2915.387768568582;502.72852659563426;503.58957449678394;514.3159597735004;519.6907839835292;556.0713608274111;473.6069062677969;529.7086602368681;567.1917517537493;584.6462889951603;596.2695697770283;7994;8287.709930152416;8292.917070829335;8352.582370881431;8474.872876906851;541.196323459662;569.9057809006717;575.683374144219;635.0125554762296;648.516854943061;4021.9597804021587;4115.71190016696;4162.687798415131;4171.20747058058;4234.788260586958;56862.147067794016;57146;57509.71245143831;86698;88103;50280.497195028314;54218.45781542213;65235.673821631535;71681;80024.59987700025;69904.65047674831;70254.64872675604;70315.64842175756;70355.29644703488;70820.29179708137;8492.787680308042;8614.698485552975;8675.305975521816;8827.69103081389;8983.101689830964;41776.79111604422;42308.36537451879;42349.78825105855;42666.78666606647;42816.14367712691;57925.420745792006;59428.70285648717;59524.40475595189;59877;60311.69844150751;10907.291026083596;11056.233263909678;11347.773044538897;11397.259178153394;11525.538978440769;11873.881261187624;11923.470452084788;12645.304508252135;13057.477700892237;13160.868391315964;11951.641450756491;12148.696282593006;12399.628011159679;12749.426275817796;12752;10634.14926805869;10738.355698658106;10863.891361086287;11079.778404432027;11203.271787334123;10669.093127084285;10691.358518488916;10941.507632156412;11678.474468648761;11952.402379881145;9833.79777070075;9944.35361701516;10039.69880903574;10307.175425965755;10424.68725938223;10357.274990750575;10465.529051192867;10514.421706805893;10617.309874858109;10628.946855265674 11:24:56 INFO - PROCESS | 4154 | __end_tp_report 11:24:56 INFO - PROCESS | 4154 | __start_cc_report 11:24:56 INFO - PROCESS | 4154 | _x_x_mozilla_cycle_collect,954 11:24:56 INFO - PROCESS | 4154 | __end_cc_report 11:24:56 INFO - PROCESS | 4154 | __startTimestamp1465064696127__endTimestamp 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | ------- Summary: start ------- 11:24:56 INFO - PROCESS | 4154 | Number of tests: 6 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | [#0] dojo.html Cycles:165 Average:4688.78 Median:4823.95 stddev:489.72 (10.2%) stddev-sans-first:465.32 11:24:56 INFO - PROCESS | 4154 | Values: 2685.4 2689.9 2715.3 2726.5 2752.8 4495.8 4588.7 4679.3 4741.6 4824.0 4681.4 4683.5 4696.2 4719.3 4728.7 4111.8 4248.5 4340.6 4364.3 4492.1 4396.6 4434.3 4449.8 4458.4 4476.8 4274.0 4298.3 4333.5 4363.4 4368.3 4325.2 4332.0 4333.0 4436.3 4451.5 4357.0 4360.1 4383.3 4407.7 4408.4 4419.7 4536.2 4617.2 4642.4 4724.6 5052.6 5065.5 5070.6 5073.1 5080.9 5076.9 5109.2 5111.3 5113.9 5118.8 4649.4 4705.5 4707.3 4741.4 4774.5 5229.5 5241.3 5250.7 5255.0 5255.4 5004.9 5051.6 5054.5 5055.1 5057.1 4947.3 4991.6 5074.5 5076.4 5142.9 5031.0 5032.6 5036.0 5036.3 5049.6 5013.8 5022.1 5022.3 5024.3 5068.9 4178.6 4217.9 4222.0 4281.4 4312.3 3755.5 3771.2 3781.8 3792.7 3825.3 4399.1 4407.2 4420.0 4446.2 4464.2 4921.8 5149.0 5193.4 5212.2 5255.7 4250.3 4319.2 4349.4 4355.2 4370.0 4573.0 4573.4 4575.5 4575.9 4619.2 4665.1 4709.2 4790.5 4797.2 4844.6 5023.2 5098.3 5148.3 5159.8 5167.4 4824.9 4825.1 4834.8 4844.8 4891.0 4909.0 5061.7 5065.7 5067.7 5128.9 5001.4 5028.2 5050.9 5112.1 5117.1 4927.7 4933.7 4938.7 4942.4 4977.8 4932.2 4935.9 4944.6 4945.6 4981.1 4728.9 4821.7 4838.8 4843.3 4881.7 5007.0 5028.7 5040.0 5053.2 5076.3 4655.0 4806.3 4858.9 4866.0 4917.8 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | [#1] ext.html Cycles:180 Average:46627.09 Median:36419.04 stddev:82743.39 (227.2%) stddev-sans-first:82903.19 11:24:56 INFO - PROCESS | 4154 | Values: 549.9 589.9 589.9 590.5 606.4 27508.0 28043.6 30219.8 39701.6 41212.8 41402.8 41872.2 41878.4 42002.2 42020.8 7723.7 7892.7 7893.1 7896.3 7902.4 7677.1 7751.1 7812.4 7815.7 7818.0 7851.1 7895.6 7897.2 7898.6 7899.6 7786.3 7826.4 7827.3 7831.9 7835.3 7749.7 7809.4 7810.7 7812.9 7817.8 38604.0 39068.2 39080.2 39084.4 39116.0 2929.3 2962.5 3304.0 3698.9 3762.5 27545.6 29618.7 29893.3 29997.6 31017.5 3413.2 3427.2 3475.0 3495.8 3549.3 245794.0 245821.0 246412.0 246665.0 247052.0 55784.0 56043.4 56057.7 56072.0 56138.4 49783.8 51581.0 55929.2 58087.4 58276.1 14451.0 14451.3 14556.9 14572.9 14577.1 11167.0 11258.9 11367.5 11441.8 11464.0 15822.4 16157.7 16164.4 16918.5 17862.6 6569.0 6797.7 6871.5 7032.8 7158.8 828.9 951.2 972.4 974.3 980.6 26395.9 27399.5 27683.2 27799.7 27890.7 1009.5 1012.3 1047.6 1051.1 1103.7 14576.6 14773.6 14853.1 15023.2 15193.6 366704.2 368909.0 369914.0 371639.0 372498.0 49709.3 50348.7 50506.0 50615.0 50628.7 1189.9 1198.9 1200.0 1201.5 1240.0 26489.2 27644.7 27777.6 28140.7 28183.9 42832.6 42932.4 42963.0 43108.4 43317.4 314072.0 314639.0 315203.0 315489.0 317260.0 21353.0 22250.6 22833.2 25735.5 26186.2 38358.4 42020.0 42076.4 42168.2 42669.8 35525.3 36392.5 36493.5 36678.6 36918.6 35286.8 35456.8 35491.3 35775.8 35996.0 35431.8 36199.0 36416.6 36421.5 36694.8 31891.7 32125.0 32513.0 32551.2 32668.2 23979.9 24195.6 24423.3 24441.5 24455.8 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | [#2] jquery.html Cycles:180 Average:23228.72 Median:49451.13 stddev:60315.82 (122.0%) stddev-sans-first:60460.59 11:24:56 INFO - PROCESS | 4154 | Values: 363.9 367.6 368.5 371.2 384.5 16542.3 16686.2 16860.8 17077.2 17122.5 15080.9 15504.4 15713.4 15733.6 15962.7 4963.7 5079.6 5134.5 5162.6 5167.8 3695.6 3863.9 5055.8 5580.7 5900.2 5947.5 5957.4 5974.6 5975.5 5977.2 5765.8 5871.3 5909.3 5915.3 5922.7 3341.8 4850.1 5172.3 5178.4 5182.3 19834.2 20453.2 20563.7 20667.9 20681.7 1846.6 2005.5 2271.8 2280.9 2488.4 12653.0 12850.6 12981.2 13004.0 13441.7 1685.9 1747.0 1762.1 1779.9 1814.2 62893.4 64065.4 65334.0 65896.0 66330.0 9391.0 9513.2 9633.2 10015.8 10121.2 13422.9 13485.6 13489.9 13512.1 13514.0 6969.4 7029.2 7072.5 7098.8 7120.3 6496.7 6630.9 6673.4 6696.5 6735.2 5924.1 6202.8 6219.1 6247.2 6342.0 1522.5 1669.8 1714.9 1736.5 1739.1 820.5 851.9 917.2 942.5 1008.6 16020.4 16558.5 16768.9 16858.3 17189.3 916.7 917.4 924.1 959.3 981.8 9092.7 9913.4 9932.5 10192.7 10323.5 364071.0 364767.0 365074.0 367754.0 369008.0 49398.8 54489.0 78040.6 78866.6 79413.0 930.5 941.8 953.9 962.0 964.8 15752.0 15811.9 15838.4 15997.3 16311.4 34549.5 35150.8 35576.3 36114.3 36631.6 46292.3 48162.3 49382.0 49503.5 49953.0 7741.0 7781.0 7789.4 7843.7 7909.0 10957.8 11395.4 11635.7 11638.5 11939.3 5076.6 9565.6 9705.7 9938.9 10281.7 9923.6 9959.6 10038.3 10074.2 10185.8 9923.6 10180.5 10255.1 10428.6 10679.6 7675.8 7683.5 7759.7 7797.7 7906.1 9164.5 9860.2 9861.5 9921.6 9981.4 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | [#3] mootools.html Cycles:180 Average:5027.47 Median:5387.85 stddev:2799.53 (52.0%) stddev-sans-first:2792.79 11:24:56 INFO - PROCESS | 4154 | Values: 1223.6 1389.9 1440.4 1513.3 1759.7 6377.6 7358.4 7633.1 7634.6 7872.6 7595.2 7728.0 7731.8 7740.4 7740.6 1828.9 2030.3 2071.2 2094.9 2123.9 2143.0 2161.3 2161.4 2164.4 2166.4 2038.0 2059.2 2071.7 2073.8 2074.6 1751.3 2004.7 2035.7 2040.2 2069.1 2077.6 2077.8 2096.4 2099.0 2099.2 7631.5 7697.8 7698.7 7706.2 7708.8 4326.7 4459.6 4460.6 4460.9 4467.1 2774.2 2934.8 2941.3 2945.4 2949.9 846.0 855.7 890.1 909.1 923.6 10488.2 10496.8 10527.6 10527.8 10528.4 3992.6 4127.3 4206.5 4210.2 4210.5 8999.6 9046.9 9068.8 9077.6 9080.4 4440.8 4450.0 4450.2 4452.0 4462.4 3496.5 3922.6 4041.1 4060.1 4121.8 3562.4 3564.6 3684.1 3734.5 3762.5 1158.3 1190.8 1192.7 1192.7 1193.0 833.9 836.6 840.4 856.1 860.5 5005.5 5095.5 5235.3 5319.2 5332.6 888.3 906.2 914.8 916.7 924.9 3451.2 3584.8 3605.5 3633.0 3648.4 9066.8 9225.7 9425.8 9442.8 9500.1 9221.1 9315.9 9390.8 9396.3 9417.5 7129.8 7272.4 7281.8 7291.3 7292.8 5383.8 5391.9 5543.6 5607.1 5636.8 8281.9 8525.8 8530.0 8530.9 8541.1 8303.4 8465.6 8526.9 8652.7 8679.0 5892.1 6072.8 6072.9 6477.9 6656.2 6170.9 7248.1 7267.0 7435.6 7455.3 6465.5 6550.6 6691.9 6746.1 6816.0 6476.1 6520.2 6530.9 6620.7 6675.6 6349.4 6367.5 6408.2 6428.0 6433.1 4547.5 4587.8 4634.5 4639.1 4714.8 4580.8 4667.4 4673.5 4704.8 4741.3 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | [#4] prototype.html Cycles:180 Average:4112.61 Median:4752.78 stddev:1205.85 (25.4%) stddev-sans-first:1174.62 11:24:56 INFO - PROCESS | 4154 | Values: 290.8 292.2 295.3 295.8 299.5 4753.4 4764.5 4766.5 4797.6 4806.4 4726.9 4737.2 4752.2 4759.9 4759.9 3541.4 3588.5 3664.8 3688.6 3746.7 3691.6 3704.2 3712.9 3742.6 3749.8 3693.2 3701.2 3710.5 3736.0 3745.1 3534.4 3612.2 3702.9 3708.7 3728.1 3246.9 3257.4 3276.9 3279.1 3282.7 4521.3 4528.0 4565.7 4590.0 4590.8 3964.7 4170.5 4257.9 4270.8 4275.4 4889.0 4912.8 4953.2 4960.2 4962.7 3469.3 3470.2 3477.3 3495.7 3516.4 5018.9 5179.3 5250.4 5257.5 5270.6 3502.9 3522.8 3533.5 3535.1 3542.4 3537.0 3562.6 3574.9 3586.9 3592.5 4132.8 4134.3 4138.6 4144.3 4153.2 4649.0 4931.7 4958.5 4975.4 4980.8 1240.4 1243.5 1247.2 1251.0 1253.3 794.1 796.4 802.5 817.3 826.0 4249.7 4396.0 4404.6 4414.2 4417.9 5078.4 5092.4 5118.6 5122.6 5133.7 4391.0 4403.2 4421.5 4421.9 4426.3 2575.3 2719.7 2723.6 2725.5 2725.7 4824.8 4851.2 4866.7 4868.5 4879.5 5086.2 5223.4 5265.0 5265.9 5299.7 4886.6 4888.8 4895.7 4898.2 4900.1 5104.5 5113.4 5115.1 5166.5 5174.1 4778.4 4992.4 5026.3 5050.1 5066.9 4836.3 4842.4 4859.6 4861.4 4865.6 3560.3 3565.6 3575.0 3587.4 3595.9 4899.9 5153.4 5156.5 5161.4 5200.5 4907.8 4925.4 4940.9 4943.6 4953.2 4920.7 4945.9 4948.2 4965.9 4966.9 4599.3 4791.6 4807.4 4846.8 4852.2 4712.2 4858.5 4958.4 4997.4 5006.2 4839.2 4864.5 4867.5 4870.7 4884.6 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - PROCESS | 4154 | [#5] yui.html Cycles:180 Average:16288.79 Median:23461.62 stddev:21458.11 (91.5%) stddev-sans-first:21486.13 11:24:56 INFO - PROCESS | 4154 | Values: 639.9 653.8 678.8 716.0 719.3 11411.7 12025.3 12280.4 12333.2 12691.1 12947.7 13028.7 13140.1 13146.7 13147.9 633.7 781.0 791.7 801.4 802.4 796.1 802.3 802.6 803.2 804.2 841.9 849.4 851.4 851.6 852.6 656.0 811.9 830.9 843.5 848.7 608.0 608.1 609.3 609.8 610.2 12564.9 12593.2 12638.4 12676.5 12682.1 12341.6 12369.4 12884.4 12898.9 13062.7 11323.7 11503.4 11598.7 11611.7 12078.8 3234.1 4102.8 4222.6 4227.8 4256.4 62373.4 63585.7 63768.7 63792.0 63820.4 10530.0 10651.8 10752.3 10889.6 11092.8 20214.0 20306.6 20904.0 20913.1 20946.8 6584.8 6671.8 6712.7 6714.0 6913.1 3734.4 3763.8 3782.8 3828.2 3854.9 2818.1 2904.0 2905.1 2906.0 2915.4 502.7 503.6 514.3 519.7 556.1 473.6 529.7 567.2 584.6 596.3 7994.0 8287.7 8292.9 8352.6 8474.9 541.2 569.9 575.7 635.0 648.5 4022.0 4115.7 4162.7 4171.2 4234.8 56862.1 57146.0 57509.7 86698.0 88103.0 50280.5 54218.5 65235.7 71681.0 80024.6 69904.7 70254.6 70315.6 70355.3 70820.3 8492.8 8614.7 8675.3 8827.7 8983.1 41776.8 42308.4 42349.8 42666.8 42816.1 57925.4 59428.7 59524.4 59877.0 60311.7 10907.3 11056.2 11347.8 11397.3 11525.5 11873.9 11923.5 12645.3 13057.5 13160.9 11951.6 12148.7 12399.6 12749.4 12752.0 10634.1 10738.4 10863.9 11079.8 11203.3 10669.1 10691.4 10941.5 11678.5 11952.4 9833.8 9944.4 10039.7 10307.2 10424.7 10357.3 10465.5 10514.4 10617.3 10628.9 11:24:56 INFO - PROCESS | 4154 | -------- Summary: end -------- 11:24:56 INFO - PROCESS | 4154 | 11:24:56 INFO - TEST-INFO | 4154: exit 0 11:24:56 INFO - TEST-OK | dromaeo_css | took 1119052ms 11:24:56 INFO - TEST-START | kraken 11:24:56 INFO - operating with platform_type : linux_ 11:24:56 INFO - Initialising browser for kraken test... 11:24:56 INFO - TEST-INFO | started process 4332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdP8Qub/profile http://localhost:47217/getInfo.html) 11:25:00 INFO - PROCESS | 4332 | __metrics Screen width/height:1600/1200 11:25:00 INFO - PROCESS | 4332 | colorDepth:24 11:25:00 INFO - PROCESS | 4332 | Browser inner width/height: 1024/697 11:25:00 INFO - PROCESS | 4332 | __metrics 11:25:01 ERROR - PROCESS | 4332 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 11:25:02 INFO - TEST-INFO | 4332: exit 0 11:25:02 INFO - Browser initialized. 11:25:02 INFO - Running cycle 1/1 for kraken test... 11:25:02 INFO - TEST-INFO | started process 4414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdP8Qub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:14 INFO - PROCESS | 4414 | RSS: Main: 157696000 11:25:14 INFO - PROCESS | 4414 | 11:25:17 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47217/tests/kraken/driver.html?testName=audio-beat-detection) 11:25:18 INFO - PROCESS | 4414 | RSS: Main: 215969792 11:25:18 INFO - PROCESS | 4414 | 11:25:21 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47217/tests/kraken/driver.html?testName=audio-dft) 11:25:21 INFO - PROCESS | 4414 | RSS: Main: 202825728 11:25:21 INFO - PROCESS | 4414 | 11:25:25 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47217/tests/kraken/driver.html?testName=audio-fft) 11:25:25 INFO - PROCESS | 4414 | RSS: Main: 271253504 11:25:25 INFO - PROCESS | 4414 | 11:25:27 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47217/tests/kraken/driver.html?testName=audio-oscillator) 11:25:28 INFO - PROCESS | 4414 | RSS: Main: 181153792 11:25:28 INFO - PROCESS | 4414 | 11:25:30 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:25:31 INFO - PROCESS | 4414 | RSS: Main: 184872960 11:25:31 INFO - PROCESS | 4414 | 11:25:34 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47217/tests/kraken/driver.html?testName=imaging-darkroom) 11:25:35 INFO - PROCESS | 4414 | RSS: Main: 221085696 11:25:35 INFO - PROCESS | 4414 | 11:25:38 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47217/tests/kraken/driver.html?testName=imaging-desaturate) 11:25:39 INFO - PROCESS | 4414 | RSS: Main: 217341952 11:25:39 INFO - PROCESS | 4414 | 11:25:42 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47217/tests/kraken/driver.html?testName=json-parse-financial) 11:25:42 INFO - PROCESS | 4414 | RSS: Main: 220114944 11:25:42 INFO - PROCESS | 4414 | 11:25:44 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:25:45 INFO - PROCESS | 4414 | RSS: Main: 206745600 11:25:45 INFO - PROCESS | 4414 | 11:25:47 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:25:47 INFO - PROCESS | 4414 | RSS: Main: 209752064 11:25:47 INFO - PROCESS | 4414 | 11:25:49 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:25:50 INFO - PROCESS | 4414 | RSS: Main: 217563136 11:25:50 INFO - PROCESS | 4414 | 11:25:53 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:25:53 INFO - PROCESS | 4414 | RSS: Main: 222720000 11:25:53 INFO - PROCESS | 4414 | 11:25:56 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:25:57 INFO - PROCESS | 4414 | RSS: Main: 221872128 11:25:57 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | Cycle 1(1): loaded http://localhost:47217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47217/tests/kraken/driver.html?testName=ai-astar) 11:25:59 INFO - PROCESS | 4414 | RSS: Main: 264466432 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | __start_tp_report 11:25:59 INFO - PROCESS | 4414 | _x_x_mozilla_page_load 11:25:59 INFO - PROCESS | 4414 | _x_x_mozilla_page_load_details 11:25:59 INFO - PROCESS | 4414 | |i|pagename|runs| 11:25:59 INFO - PROCESS | 4414 | |0;ai-astar;112;109;114;114;112;113;112;111;112;112 11:25:59 INFO - PROCESS | 4414 | |1;audio-beat-detection;175;131;133;184;130;133;158;133;186;139 11:25:59 INFO - PROCESS | 4414 | |2;audio-dft;163;161;161;162;163;162;163;163;164;162 11:25:59 INFO - PROCESS | 4414 | |3;audio-fft;76;76;75;103;77;77;76;75;100;75 11:25:59 INFO - PROCESS | 4414 | |4;audio-oscillator;88;88;120;85;86;87;114;87;87;135 11:25:59 INFO - PROCESS | 4414 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;117 11:25:59 INFO - PROCESS | 4414 | |6;imaging-darkroom;147;146;147;147;146;146;146;146;146;146 11:25:59 INFO - PROCESS | 4414 | |7;imaging-desaturate;94;96;95;95;95;95;95;95;95;95 11:25:59 INFO - PROCESS | 4414 | |8;json-parse-financial;65;64;64;65;65;65;63;65;64;64 11:25:59 INFO - PROCESS | 4414 | |9;json-stringify-tinderbox;64;66;66;65;65;65;76;65;65;66 11:25:59 INFO - PROCESS | 4414 | |10;stanford-crypto-aes;92;84;83;90;85;85;85;85;117;83 11:25:59 INFO - PROCESS | 4414 | |11;stanford-crypto-ccm;146;139;132;134;130;129;128;130;146;134 11:25:59 INFO - PROCESS | 4414 | |12;stanford-crypto-pbkdf2;171;171;172;172;171;169;167;167;167;170 11:25:59 INFO - PROCESS | 4414 | |13;stanford-crypto-sha256-iterative;72;68;67;67;70;70;68;68;65;66 11:25:59 INFO - PROCESS | 4414 | __end_tp_report 11:25:59 INFO - PROCESS | 4414 | __start_cc_report 11:25:59 INFO - PROCESS | 4414 | _x_x_mozilla_cycle_collect,1895 11:25:59 INFO - PROCESS | 4414 | __end_cc_report 11:25:59 INFO - PROCESS | 4414 | __startTimestamp1465064759538__endTimestamp 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | ------- Summary: start ------- 11:25:59 INFO - PROCESS | 4414 | Number of tests: 14 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:1.45 (1.3%) stddev-sans-first:1.54 11:25:59 INFO - PROCESS | 4414 | Values: 112.0 109.0 114.0 114.0 112.0 113.0 112.0 111.0 112.0 112.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#1] audio-beat-detection Cycles:10 Average:150.20 Median:148.50 stddev:23.31 (15.7%) stddev-sans-first:22.93 11:25:59 INFO - PROCESS | 4414 | Values: 175.0 131.0 133.0 184.0 130.0 133.0 158.0 133.0 186.0 139.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 11:25:59 INFO - PROCESS | 4414 | Values: 163.0 161.0 161.0 162.0 163.0 162.0 163.0 163.0 164.0 162.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.85 (14.3%) stddev-sans-first:11.36 11:25:59 INFO - PROCESS | 4414 | Values: 76.0 76.0 75.0 103.0 77.0 77.0 76.0 75.0 100.0 75.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:87.00 stddev:18.21 (20.9%) stddev-sans-first:18.97 11:25:59 INFO - PROCESS | 4414 | Values: 88.0 88.0 120.0 85.0 86.0 87.0 114.0 87.0 87.0 135.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:25:59 INFO - PROCESS | 4414 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 11:25:59 INFO - PROCESS | 4414 | Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 11:25:59 INFO - PROCESS | 4414 | Values: 94.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 11:25:59 INFO - PROCESS | 4414 | Values: 65.0 64.0 64.0 65.0 65.0 65.0 63.0 65.0 64.0 64.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:65.50 stddev:3.47 (5.3%) stddev-sans-first:3.57 11:25:59 INFO - PROCESS | 4414 | Values: 64.0 66.0 66.0 65.0 65.0 65.0 76.0 65.0 65.0 66.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:85.00 stddev:10.30 (12.1%) stddev-sans-first:10.86 11:25:59 INFO - PROCESS | 4414 | Values: 92.0 84.0 83.0 90.0 85.0 85.0 85.0 85.0 117.0 83.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:134.00 stddev:6.70 (5.0%) stddev-sans-first:5.75 11:25:59 INFO - PROCESS | 4414 | Values: 146.0 139.0 132.0 134.0 130.0 129.0 128.0 130.0 146.0 134.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:171.00 stddev:2.06 (1.2%) stddev-sans-first:2.13 11:25:59 INFO - PROCESS | 4414 | Values: 171.0 171.0 172.0 172.0 171.0 169.0 167.0 167.0 167.0 170.0 11:25:59 INFO - PROCESS | 4414 | 11:25:59 INFO - PROCESS | 4414 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.00 stddev:2.08 (3.1%) stddev-sans-first:1.66 11:25:59 INFO - PROCESS | 4414 | Values: 72.0 68.0 67.0 67.0 70.0 70.0 68.0 68.0 65.0 66.0 11:25:59 INFO - PROCESS | 4414 | -------- Summary: end -------- 11:25:59 INFO - PROCESS | 4414 | 11:26:00 INFO - TEST-INFO | 4414: exit 0 11:26:00 INFO - TEST-OK | kraken | took 63718ms 11:26:00 INFO - SUITE-END | took 1182s 11:26:00 INFO - Completed test suite (00:19:42) 11:26:00 INFO - javascript benchmark 11:26:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2685.4226341336616, 2689.932751681209, 2715.3203120324, 2726.4819684259987, 2752.8485933273673, 4495.820167193308, 4588.678792484528, 4679.251319788835, 4741.620670346377, 4823.951760482394, 4681.368015317931, 4683.531646835315, 4696.201645720227, 4719.315699223611, 4728.66899317048, 4111.814968326433, 4248.468941382335, 4340.609345158935, 4364.258076127066, 4492.10157968406, 4396.582324679151, 4434.312681534368, 4449.822007119711, 4458.4426946631675, 4476.843310484133, 4274.0, 4298.31227003681, 4333.544977777351, 4363.410939523155, 4368.322909948947, 4325.178216138924, 4331.956680433187, 4333.046729719456, 4436.290193569013, 4451.5103338632725, 4356.978215108936, 4360.149770794696, 4383.320585309282, 4407.713498622579, 4408.3607876858, 4419.668524860648, 4536.228841097021, 4617.215073437524, 4642.442906851199, 4724.5984091352275, 5052.570531504826, 5065.518775716301, 5070.645054846163, 5073.112205364084, 5080.898382032376, 5076.898462030738, 5109.182530795055, 5111.258867464197, 5113.897722045538, 5118.769655365518, 4649.418822647169, 4705.505921878222, 4707.317438971399, 4741.407324084489, 4774.546418090275, 5229.50319719626, 5241.292425522505, 5250.737463126905, 5255.0, 5255.39562950258, 5004.949950500449, 5051.646384753106, 5054.469280725544, 5055.064813009605, 5057.140286151363, 4947.282644016597, 4991.625628077909, 5074.5179207975925, 5076.44159142494, 5142.922856157161, 5030.974845125824, 5032.597392208614, 5036.043151801146, 5036.294918711384, 5049.5707864831165, 5013.849584512471, 5022.146235140035, 5022.296878437021, 5024.271480635361, 5068.873278168076, 4178.603032711888, 4217.894552636148, 4222.0, 4281.357796330575, 4312.331588603772, 3755.4742336072973, 3771.2080463102507, 3781.7920014399474, 3792.6965842732516, 3825.311443940062, 4399.076193999232, 4407.184670835905, 4419.955800442019, 4446.244138496463, 4464.196444639931, 4921.803127874845, 5148.9742551287, 5193.3767947845745, 5212.166053431509, 5255.710935898563, 4250.277452833026, 4319.222539942841, 4349.391085248068, 4355.1725172217175, 4370.0, 4572.977135114304, 4573.359729637853, 4575.542445755398, 4575.931361029588, 4619.19164146273, 4665.066986602626, 4709.1994360958715, 4790.520947905182, 4797.184478638709, 4844.612431005511, 5023.196288593807, 5098.337216161875, 5148.30497882781, 5159.845204643867, 5167.379914410295, 4824.8793780155775, 4825.083234185494, 4834.806607735652, 4844.781984810763, 4891.021795640815, 4909.0, 5061.670991385548, 5065.696058236517, 5067.746612669425, 5128.923066153936, 5001.449840517613, 5028.245763135559, 5050.898982020412, 5112.054269960069, 5117.1300878851425, 4927.728974906415, 4933.654644174873, 4938.678985865908, 4942.406911170682, 4977.800887964586, 4932.21084626458, 4935.876603084952, 4944.579710724629, 4945.579625731853, 4981.103401387785, 4728.881777955441, 4821.686590371614, 4838.782254798472, 4843.321934929042, 4881.658283920092, 5007.0, 5028.723420211923, 5039.974800125976, 5053.191489361684, 5076.263941728354, 4654.953450465452, 4806.327114203944, 4858.878528036827, 4866.0, 4917.754112294299], "value": 4658.350960473104, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.914763211702, 589.9026660601002, 589.911513273009, 590.4597293476467, 606.372404561279, 27508.0, 28043.579346309823, 30219.848900755493, 39701.60298397015, 41212.79393603035, 41402.79298603503, 41872.162556748845, 41878.371824422655, 42002.159956800846, 42020.789896050555, 7723.72966946157, 7892.723754668587, 7893.092294386133, 7896.328812050982, 7902.367810575169, 7677.078750549942, 7751.147373788879, 7812.414068944823, 7815.687372505093, 7818.0, 7851.057873055212, 7895.605219739019, 7897.170797066312, 7898.644560994769, 7899.565523896184, 7786.260305271018, 7826.413019023567, 7827.25641064098, 7831.921680783234, 7835.255650713173, 7749.728759493447, 7809.3752499799875, 7810.726624568169, 7812.921870781276, 7817.804554886116, 38604.0, 39068.21863562741, 39080.21839563193, 39084.41373379402, 39116.0, 2929.326254961371, 2962.4963756161505, 3303.96696033039, 3698.85204591816, 3762.5108735864164, 27545.586816197574, 29618.70381296181, 29893.252668683457, 29997.550036749468, 31017.534736978963, 3413.2149605590603, 3427.1774774054297, 3475.0, 3495.790252584853, 3549.3078849624335, 245794.0, 245821.0, 246412.0, 246664.9999999982, 247052.0, 55784.0, 56043.43956560464, 56057.71971140118, 56072.0, 56138.43861561332, 49783.751081244365, 51581.0, 55929.161062583276, 58087.41912580904, 58276.125858112166, 14451.0, 14451.277436128361, 14556.927215364067, 14572.854271457361, 14577.052491588012, 11166.994970452699, 11258.887411125948, 11367.54529818798, 11441.828372574419, 11464.025557827512, 15822.367105315889, 16157.67684646324, 16164.434244801376, 16918.492445226664, 17862.55343616394, 6569.0, 6797.694103765342, 6871.484638652021, 7032.753853615099, 7158.8210294742, 828.8590939540293, 951.2390087929629, 972.4214092614883, 974.2741657465234, 980.6175591519313, 26395.868020659775, 27399.452010960067, 27683.169504914884, 27799.722002779712, 27890.72109278922, 1009.4548943570389, 1012.2559918459926, 1047.5966752800227, 1051.0989668514953, 1103.7406209540752, 14576.635584110481, 14773.556793296219, 14853.10881347101, 15023.248837558078, 15193.62015949588, 366704.16647917125, 368909.0, 369914.0, 371639.0, 372498.0, 49709.25436118461, 50348.748256258485, 50506.0, 50615.0, 50628.74685626622, 1189.9144292934857, 1198.8501437320335, 1199.9580014699618, 1201.5133870782347, 1240.0327744359415, 26489.205323840317, 27644.723552764215, 27777.583336250376, 28140.71859281463, 28183.859080704464, 42832.57167428286, 42932.35601466043, 42963.0, 43108.353374698774, 43317.35023974706, 314072.0, 314639.0, 315203.0, 315489.0, 317260.0, 21353.0, 22250.554988900454, 22833.20083797059, 25735.485290294462, 26186.214413567624, 38358.42462363011, 42020.0, 42076.36885446782, 42168.15663686648, 42669.78665106655, 35525.28949420946, 36392.454113188855, 36493.45259821052, 36678.63321366859, 36918.63081369152, 35286.823565882005, 35456.82271588626, 35491.33751887418, 35775.82112089423, 35996.0, 35431.82284088563, 36199.0, 36416.63583364239, 36421.45367819432, 36694.8165259172, 31891.6810831898, 32125.03624891257, 32513.0, 32551.18622034468, 32668.183295417806, 23979.880100599385, 24195.63706544368, 24423.270555674215, 24441.51116977686, 24455.75544244606], "value": 17499.8445251646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.9290338384016, 367.61767761528006, 368.46756436948584, 371.23896013173, 384.5423945504849, 16542.338306467744, 16686.249118789652, 16860.83139168608, 17077.23152458139, 17122.486325410227, 15080.867042498277, 15504.379824806994, 15713.371465141381, 15733.60665983351, 15962.680746385066, 4963.677360971535, 5079.568236699885, 5134.486551344854, 5162.586993040548, 5167.767450464738, 3695.5750088739737, 3863.864764733235, 5055.823046193384, 5580.748866301006, 5900.1739756434135, 5947.464728174464, 5957.374475680034, 5974.55190860685, 5975.462208401243, 5977.163197152402, 5765.798197063083, 5871.324797648261, 5909.349971503131, 5915.290165180184, 5922.703864806743, 3341.849616767227, 4850.102730994778, 5172.250023746536, 5178.378594568639, 5182.274481572583, 19834.206631734713, 20453.181872725072, 20563.691544626843, 20667.89666051675, 20681.68977465339, 1846.5752876838403, 2005.4986253436641, 2271.7728227177317, 2280.905165520543, 2488.390344365624, 12653.0, 12850.614481565475, 12981.221126732426, 13004.0, 13441.66395840102, 1685.8651307895461, 1746.9912650436793, 1762.1013283225648, 1779.9377021804175, 1814.1564172659776, 62893.37106628921, 64065.3593464064, 65334.0, 65895.99999999952, 66330.0, 9390.953045234866, 9513.238940884712, 9633.229341652652, 10015.849762253572, 10121.24090693201, 13422.932885335511, 13485.595432137052, 13489.932550337186, 13512.121712088683, 13513.986451016213, 6969.4424446044195, 7029.191642961023, 7072.469564782662, 7098.751543695946, 7120.323569260912, 6496.707648155844, 6630.867382652416, 6673.366030227217, 6696.531242812956, 6735.225449073321, 5924.11138329254, 6202.844928876814, 6219.0982307566055, 6247.156633854463, 6342.048692696132, 1522.454708470903, 1669.8394615742186, 1714.9399771008204, 1736.5398169485097, 1739.052261467165, 820.526113766993, 851.8892543969245, 917.2249449215402, 942.472215559289, 1008.5511947183433, 16020.359185632677, 16558.503244902433, 16768.916155419145, 16858.325666973185, 17189.31242750301, 916.7249825052457, 917.4266083697689, 924.0574613893925, 959.3476436023572, 981.8379967305458, 9092.727218183465, 9913.355631883904, 9932.453715045598, 10192.745181370525, 10323.48382580868, 364071.0, 364767.0, 365074.0, 367754.0, 369008.0, 49398.753006235456, 54489.0, 78040.60979695065, 78866.60566697245, 79413.0, 930.5161316115717, 941.8493041113389, 953.909378609031, 961.9711408657612, 964.7588102974116, 15752.0, 15811.920940395685, 15838.366465341258, 15997.280122394288, 16311.429099981444, 34549.48175777315, 35150.824245878604, 35576.28847423089, 36114.27771444504, 36631.633683662825, 46292.30561541512, 48162.27756583724, 49382.0, 49503.50496495133, 49953.0, 7740.961295193488, 7780.961095194488, 7789.376849851885, 7843.686252550062, 7908.960455197687, 10957.83563246568, 11395.373254471084, 11635.650930472098, 11638.53445862156, 11939.283642981449, 5076.619253555924, 9565.617375305188, 9705.661885962834, 9938.850917236103, 10281.691549253534, 9923.553440095357, 9959.551820167964, 10038.297319187586, 10074.244431667508, 10185.796284074426, 9923.55344009507, 10180.490975451346, 10255.128314093387, 10428.634997775041, 10679.626213082505, 7675.769726908202, 7683.538987660758, 7759.650815713419, 7797.688092476237, 7906.090799557895, 9164.495952722664, 9860.211183105477, 9861.457619830979, 9921.55353009102, 9981.401115933068], "value": 8249.053210800132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1223.5962132496277, 1389.8888088952885, 1440.3950340856838, 1513.273628658244, 1759.7184450487925, 6377.61734295942, 7358.448116391272, 7633.084029916417, 7634.58009809461, 7872.645730942107, 7595.240475952416, 7728.033995750531, 7731.806704832382, 7740.419468539854, 7740.574268415235, 1828.945131646046, 2030.2792508659434, 2071.1715313874497, 2094.89525523724, 2123.8725676459385, 2142.967855482169, 2161.275972549198, 2161.4056134562966, 2164.361513353557, 2166.393409845246, 2037.9796202037937, 2059.166037754704, 2071.6996035574834, 2073.8340932725423, 2074.636938535758, 1751.290727255457, 2004.7494063242095, 2035.745531808524, 2040.2451093095501, 2069.0689189864547, 2077.6156411064003, 2077.8337732981477, 2096.381567437594, 2098.9790102098937, 2099.1603358656507, 7631.465797394185, 7697.846043079107, 7698.653560589787, 7706.152323244439, 7708.768736937901, 4326.697131200817, 4459.576340247671, 4460.553944605514, 4460.907077765935, 4467.128909862578, 2774.153883065664, 2934.8092373995623, 2941.2793865502877, 2945.3520225550346, 2949.941001179986, 846.0, 855.7261676263598, 890.0520945193348, 909.0999910088964, 923.607466826596, 10488.213383996155, 10496.790064198673, 10527.578896844117, 10527.84208236877, 10528.36829790215, 3992.5608183099835, 4127.29835927893, 4206.537280899099, 4210.157968406331, 4210.473690788652, 8999.640014399482, 9046.86429703555, 9068.81862362749, 9077.591508382138, 9080.40977336471, 4440.755758433317, 4450.043240703199, 4450.1767173073085, 4451.977740111279, 4462.41988541494, 3496.5454490916018, 3922.607739226112, 4041.0503531670033, 4060.147369052532, 4121.814518346681, 3562.3587754203973, 3564.6078931317534, 3684.097396137963, 3734.533183352081, 3762.529683789526, 1158.2760774515928, 1190.7737529869298, 1192.7197108679454, 1192.7256730951929, 1193.0455635491746, 833.9159093178844, 836.5608055770768, 840.3781201910542, 856.1181982557976, 860.4966094834467, 5005.499450055038, 5095.541401273903, 5235.267062611238, 5319.2021196820015, 5332.626716129911, 888.3337496877342, 906.211595911548, 914.794171311463, 916.7295647783919, 924.856647219682, 3451.2062225688233, 3584.8386822593047, 3605.4772058051435, 3632.9636703632627, 3648.3615367310613, 9066.773330666787, 9225.677101301422, 9425.764355891157, 9442.811143777086, 9500.097490738368, 9221.077892210726, 9315.906840931639, 9390.765230869283, 9396.295277854051, 9417.482038487811, 7129.750458734024, 7272.381847543018, 7281.834906414948, 7291.34377905991, 7292.781216563618, 5383.838484845461, 5391.86520336979, 5543.556515478833, 5607.130894711327, 5636.830895072991, 8281.875771863548, 8525.786855328666, 8529.95735021321, 8530.872036919576, 8541.103184165573, 8303.377246706643, 8465.57672116404, 8526.872096918427, 8652.697155599524, 8679.045305016316, 5892.145638882424, 6072.817815465543, 6072.939270607414, 6477.8704425912165, 6656.2345330287635, 6170.876582468415, 7248.130224373109, 7266.96366518164, 7435.628218589157, 7455.329020388191, 6465.482761379172, 6550.6069635822005, 6691.866162676816, 6746.089277947414, 6815.965920170367, 6476.093346931528, 6520.18497687789, 6530.934690653033, 6620.735170593122, 6675.566088204251, 6349.428551430394, 6367.490600752021, 6408.198975128109, 6427.967860160669, 6433.131527243762, 4547.477040140427, 4587.839425620087, 4634.513376095596, 4639.095376401569, 4714.787834547385, 4580.793864276049, 4667.369905062773, 4673.462551806586, 4704.764761761967, 4741.312509686145], "value": 4058.667102262012, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.84439824693794, 292.2139444893237, 295.25153735281066, 295.7855554722825, 299.49684529989617, 4753.3820603321565, 4764.546813221966, 4766.475687674353, 4797.640176986727, 4806.423229212491, 4726.881827954303, 4737.242041273397, 4752.16837053516, 4759.904801903968, 4759.928601070987, 3541.4333706607013, 3588.5155504006884, 3664.8167591620445, 3688.6311368863167, 3746.6815320697774, 3691.6123807000145, 3704.2406306707194, 3712.851485940559, 3742.6257374262627, 3749.756265842725, 3693.1874987502706, 3701.167237371597, 3710.4805327254207, 3736.0, 3745.1198968242443, 3534.4344904815234, 3612.151144481045, 3702.907427314312, 3708.6662200401825, 3728.086618778417, 3246.9188270293193, 3257.364813861298, 3276.885309014197, 3279.1310302769784, 3282.720968717662, 4521.276595744665, 4527.977360113211, 4565.657575681837, 4590.0, 4590.816367345302, 3964.682825373963, 4170.52039015514, 4257.850975215883, 4270.765107919063, 4275.4228179195725, 4888.9755551222015, 4912.828051018233, 4953.23224900141, 4960.23116416956, 4962.702237865704, 3469.271452994874, 3470.201853573692, 3477.2523907360037, 3495.6853883150384, 3516.3670539302916, 5018.899622007576, 5179.290834024763, 5250.44870288618, 5257.5005374489365, 5270.578353731692, 3502.877399291013, 3522.7534072615185, 3533.5229743984746, 3535.1338921964284, 3542.415501442233, 3537.02731748766, 3562.6437356264164, 3574.857005719794, 3586.9103272418397, 3592.479090531858, 4132.772697501606, 4134.3178375568295, 4138.606832350922, 4144.274751918402, 4153.169366126786, 4649.0, 4931.654784165074, 4958.454569997298, 4975.402951645826, 4980.800767969241, 1240.3550153920091, 1243.4839541590138, 1247.2267194339386, 1250.9624711258496, 1253.348258905364, 794.1343935110757, 796.3947399975945, 802.5064585280011, 817.3461231015164, 825.9504429734235, 4249.723767955073, 4395.978020109879, 4404.625606823456, 4414.249577571821, 4417.889552761207, 5078.3905931287745, 5092.439831618519, 5118.641695081383, 5122.590192784568, 5133.717645529532, 4391.0, 4403.185410699031, 4421.469423669116, 4421.867343979686, 4426.313921342197, 2575.3046677396997, 2719.73532307478, 2723.577845433961, 2725.523033469135, 2725.713800051006, 4824.782884770194, 4851.175300198975, 4866.683665561727, 4868.537488938545, 4879.536444037882, 5086.21163719624, 5223.373195216523, 5265.0, 5265.868353291198, 5299.708516031578, 4886.584640305614, 4888.780004899788, 4895.7062576245535, 4898.187670561915, 4900.117978763857, 5104.515071068243, 5113.4375218726655, 5115.053715062725, 5166.509181627739, 5174.111449320895, 4778.37881075458, 4992.375953005874, 5026.296318515338, 5050.141475949171, 5066.898662026812, 4836.298736683231, 4842.4189097308545, 4859.562639362474, 4861.392325959255, 4865.58642515376, 3560.2701446203982, 3565.607783143904, 3574.9642503574632, 3587.443946188345, 3595.9280814384088, 4899.926501102415, 5153.3558305211845, 5156.484351564814, 5161.432242453252, 5200.531952124327, 4907.779149938333, 4925.408950925912, 4940.851774446773, 4943.5797957174045, 4953.182724850503, 4920.72935988524, 4945.876353091202, 4948.208286674115, 4965.875853103701, 4966.8758281043265, 4599.264117741145, 4791.616670666408, 4807.375041244616, 4846.781894814812, 4852.223644216909, 4712.246040633482, 4858.46556878736, 4958.380202474691, 4997.350344455198, 5006.1739812930455, 4839.249916262985, 4864.513548645107, 4867.5132486751045, 4870.732109733999, 4884.584810291165], "value": 3727.130416624714, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.9488040956724, 653.7940548727148, 678.7827895073575, 715.9785206443806, 719.2807192807193, 11411.714707132325, 12025.338606376647, 12280.385980700963, 12333.198342107768, 12691.11162218645, 12947.741045179091, 13028.73942521149, 13140.14589051711, 13146.737065258689, 13147.868521314784, 633.7148283272546, 780.9921900781005, 791.6714563456159, 801.374927556504, 802.3741481644327, 796.0964305513227, 802.3100133884855, 802.574635443216, 803.1526739290047, 804.2078552625659, 841.877927700483, 849.4096602861014, 851.4380508864151, 851.5827244650108, 852.5524099847598, 656.0, 811.930985866202, 830.9459885107449, 843.5360551696573, 848.70295396611, 607.9574429789916, 608.0544752909225, 609.3388673289486, 609.7743834781115, 610.1579819848625, 12564.937175314066, 12593.244405335709, 12638.431270592846, 12676.492940282378, 12682.112252142353, 12341.568045118378, 12369.381530923418, 12884.355782210945, 12898.87101128986, 13062.673433164247, 11323.660290191307, 11503.367314797682, 11598.652040438801, 11611.710139740226, 12078.758424831454, 3234.094453552985, 4102.835886564534, 4222.641075508585, 4227.767472788995, 4256.44666193396, 62373.37626623766, 63585.68207158981, 63768.68115659392, 63792.0, 63820.361796381905, 10530.0, 10651.786964260671, 10752.301100428447, 10889.618863339745, 11092.778144437067, 20214.0, 20306.593868122556, 20904.0, 20913.05891234898, 20946.79053209479, 6584.8024559263295, 6671.833204169838, 6712.731490740413, 6714.01032771001, 6913.066735990677, 3734.3838266686234, 3763.7741735495956, 3782.829772660237, 3828.157805282833, 3854.9229015419533, 2818.070036887822, 2903.970960290412, 2905.1429828200307, 2906.0264811288034, 2915.387768568582, 502.72852659563426, 503.58957449678394, 514.3159597735004, 519.6907839835292, 556.0713608274111, 473.6069062677969, 529.7086602368681, 567.1917517537493, 584.6462889951603, 596.2695697770283, 7994.0, 8287.709930152416, 8292.917070829335, 8352.582370881431, 8474.872876906851, 541.196323459662, 569.9057809006717, 575.683374144219, 635.0125554762296, 648.516854943061, 4021.9597804021587, 4115.71190016696, 4162.687798415131, 4171.20747058058, 4234.788260586958, 56862.147067794016, 57146.0, 57509.71245143831, 86698.0, 88103.0, 50280.497195028314, 54218.45781542213, 65235.673821631535, 71681.0, 80024.59987700025, 69904.65047674831, 70254.64872675604, 70315.64842175756, 70355.29644703488, 70820.29179708137, 8492.787680308042, 8614.698485552975, 8675.305975521816, 8827.69103081389, 8983.101689830964, 41776.79111604422, 42308.36537451879, 42349.78825105855, 42666.78666606647, 42816.14367712691, 57925.420745792006, 59428.70285648717, 59524.40475595189, 59877.0, 60311.69844150751, 10907.291026083596, 11056.233263909678, 11347.773044538897, 11397.259178153394, 11525.538978440769, 11873.881261187624, 11923.470452084788, 12645.304508252135, 13057.477700892237, 13160.868391315964, 11951.641450756491, 12148.696282593006, 12399.628011159679, 12749.426275817796, 12752.0, 10634.14926805869, 10738.355698658106, 10863.891361086287, 11079.778404432027, 11203.271787334123, 10669.093127084285, 10691.358518488916, 10941.507632156412, 11678.474468648761, 11952.402379881145, 9833.79777070075, 9944.35361701516, 10039.69880903574, 10307.175425965755, 10424.68725938223, 10357.274990750575, 10465.529051192867, 10514.421706805893, 10617.309874858109, 10628.946855265674], "value": 6510.619820422293, "unit": "score"}], "name": "dromaeo_css", "value": 6360.877308561314, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 109.0, 114.0, 114.0, 112.0, 113.0, 112.0, 111.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 131.0, 133.0, 184.0, 130.0, 133.0, 158.0, 133.0, 186.0, 139.0], "value": 150.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 161.0, 162.0, 163.0, 162.0, 163.0, 163.0, 164.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 103.0, 77.0, 77.0, 76.0, 75.0, 100.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 120.0, 85.0, 86.0, 87.0, 114.0, 87.0, 87.0, 135.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 63.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 65.0, 65.0, 76.0, 65.0, 65.0, 66.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 83.0, 90.0, 85.0, 85.0, 85.0, 85.0, 117.0, 83.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 132.0, 134.0, 130.0, 129.0, 128.0, 130.0, 146.0, 134.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 172.0, 172.0, 171.0, 169.0, 167.0, 167.0, 167.0, 170.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 67.0, 67.0, 70.0, 70.0, 68.0, 68.0, 65.0, 66.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1553.7, "alertThreshold": 2.0}]} 11:26:00 INFO - Return code: 0 11:26:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:26:00 ERROR - # TBPL SUCCESS # 11:26:00 INFO - Running post-action listener: _resource_record_post_action 11:26:00 INFO - ##### 11:26:00 INFO - ##### Finished run-tests step (success) 11:26:00 INFO - ##### 11:26:00 INFO - Running post-run listener: _resource_record_post_run 11:26:00 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 522829824; Read time: 16; Write time: 381472 11:26:00 INFO - TinderboxPrint: CPU usage
13.1% 11:26:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 11:26:00 INFO - TinderboxPrint: I/O write bytes / time
522,829,824 / 381,472 11:26:00 INFO - TinderboxPrint: CPU idle
8,322.6 (86.9%) 11:26:00 INFO - TinderboxPrint: CPU user
1,212.8 (12.7%) 11:26:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:26:00 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237314048; Read time: 0; Write time: 210384 11:26:00 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 285515776; Read time: 16; Write time: 171088 11:26:01 INFO - Running post-run listener: _upload_blobber_files 11:26:01 INFO - Blob upload gear active. 11:26:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:26:01 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 11:26:01 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:26:01 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:26:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:26:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:26:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:03 INFO - (blobuploader) - INFO - Done attempting. 11:26:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:26:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:07 INFO - (blobuploader) - INFO - Done attempting. 11:26:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:26:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:26:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:26:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:26:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:26:07 INFO - (blobuploader) - INFO - Done attempting. 11:26:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:26:07 INFO - Return code: 0 11:26:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:26:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:26:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c56001cb7472788b5c1e7561e6aba10d2705d25255ea092a3475d0dfd9d319c6382f6a338ac70584f9da940a7c1412d09e7e3d20cc073a589e5f593f946ddc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8955521150e36c04b7ba81dc17b6984757f54be847807848d26f5cbb8e90d6f7f9648d7bd11de6e9e74ee9ffd2114cf7fd37cb8408948ae2830feb7a2869534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f03b8f36f10acbe9e612abde2c0de3b305ea81c3c58edb5df71a8f074dab0b515c2dfe99a96c0f2c4cce7d3b0bdb46a4ce57e60403096d5d3329d7fe2dcedb27"} 11:26:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:26:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:26:07 INFO - Contents: 11:26:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7c56001cb7472788b5c1e7561e6aba10d2705d25255ea092a3475d0dfd9d319c6382f6a338ac70584f9da940a7c1412d09e7e3d20cc073a589e5f593f946ddc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8955521150e36c04b7ba81dc17b6984757f54be847807848d26f5cbb8e90d6f7f9648d7bd11de6e9e74ee9ffd2114cf7fd37cb8408948ae2830feb7a2869534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f03b8f36f10acbe9e612abde2c0de3b305ea81c3c58edb5df71a8f074dab0b515c2dfe99a96c0f2c4cce7d3b0bdb46a4ce57e60403096d5d3329d7fe2dcedb27"} 11:26:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:26:07 INFO - Copying logs to upload dir... 11:26:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:26:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.471627 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-04 11:26:07.414934) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 11:26:07.418958) ========= 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=232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274 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-Non-PGO/sha512/7c56001cb7472788b5c1e7561e6aba10d2705d25255ea092a3475d0dfd9d319c6382f6a338ac70584f9da940a7c1412d09e7e3d20cc073a589e5f593f946ddc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8955521150e36c04b7ba81dc17b6984757f54be847807848d26f5cbb8e90d6f7f9648d7bd11de6e9e74ee9ffd2114cf7fd37cb8408948ae2830feb7a2869534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f03b8f36f10acbe9e612abde2c0de3b305ea81c3c58edb5df71a8f074dab0b515c2dfe99a96c0f2c4cce7d3b0bdb46a4ce57e60403096d5d3329d7fe2dcedb27"} build_url:https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/PdU4ZvhOSDayZucYW_fr5Q/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-Non-PGO/sha512/7c56001cb7472788b5c1e7561e6aba10d2705d25255ea092a3475d0dfd9d319c6382f6a338ac70584f9da940a7c1412d09e7e3d20cc073a589e5f593f946ddc8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c8955521150e36c04b7ba81dc17b6984757f54be847807848d26f5cbb8e90d6f7f9648d7bd11de6e9e74ee9ffd2114cf7fd37cb8408948ae2830feb7a2869534", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f03b8f36f10acbe9e612abde2c0de3b305ea81c3c58edb5df71a8f074dab0b515c2dfe99a96c0f2c4cce7d3b0bdb46a4ce57e60403096d5d3329d7fe2dcedb27"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-04 11:26:07.443985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:26:07.444345) ========= 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=232498196343f89f466a4a9a000001c8-1465063148.324373-1449817274 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-04 11:26:07.530295) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 11:26:07.530628) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-04 11:26:07.530908) ========= ========= Total master_lag: 0.16 =========