builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1465454485.55 results: success (0) buildid: 20160608173003 builduid: 5409e863a65f46c7a617fd02e75a93b5 revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.545390) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.545927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.546224) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.614611) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.614998) ========= 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=df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-08 23:41:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.4M=0s 2016-06-08 23:41:25 (46.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.077280 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.734709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.734997) ========= 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=df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016506 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.797091) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.797449) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8a447c89176fb240f78db350e8d65f62d0a6fabb --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 8a447c89176fb240f78db350e8d65f62d0a6fabb --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=df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 23:41:26,017 truncating revision to first 12 chars 2016-06-08 23:41:26,017 Setting DEBUG logging. 2016-06-08 23:41:26,017 attempt 1/10 2016-06-08 23:41:26,017 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8a447c89176f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-08 23:41:26,598 unpacking tar archive at: fx-team-8a447c89176f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975952 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.794701) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.795008) ========= script_repo_revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.795423) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.795767) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.808415) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 38 secs) (at 2016-06-08 23:41:26.808702) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:41:27 INFO - MultiFileLogger online at 20160608 23:41:27 in /builds/slave/test 23:41:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:41:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:41:27 INFO - {'append_to_log': False, 23:41:27 INFO - 'base_work_dir': '/builds/slave/test', 23:41:27 INFO - 'blob_upload_branch': 'Fx-Team', 23:41:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:41:27 INFO - 'branch': 'Fx-Team', 23:41:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:41:27 INFO - 'config_files': ('talos/linux_config.py',), 23:41:27 INFO - 'default_actions': ('clobber', 23:41:27 INFO - 'read-buildbot-config', 23:41:27 INFO - 'download-and-extract', 23:41:27 INFO - 'populate-webroot', 23:41:27 INFO - 'create-virtualenv', 23:41:27 INFO - 'install', 23:41:27 INFO - 'run-tests'), 23:41:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:41:27 INFO - 'download_minidump_stackwalk': True, 23:41:27 INFO - 'download_symbols': 'ondemand', 23:41:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:41:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:41:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:41:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:41:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:41:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:41:27 INFO - 'installer_path': 'installer.exe', 23:41:27 INFO - 'log_level': 'info', 23:41:27 INFO - 'log_name': 'talos', 23:41:27 INFO - 'log_to_console': True, 23:41:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:41:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:41:27 INFO - 'opt_config_files': (), 23:41:27 INFO - 'pip_index': False, 23:41:27 INFO - 'sps_profile': False, 23:41:27 INFO - 'sps_profile_interval': 0, 23:41:27 INFO - 'suite': 'dromaeojs', 23:41:27 INFO - 'system_bits': '32', 23:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:41:27 INFO - 'title': 'talos-linux64-ix-021', 23:41:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:41:27 INFO - 'use_talos_json': True, 23:41:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:41:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:41:27 INFO - 'work_dir': 'build'} 23:41:27 INFO - ##### 23:41:27 INFO - ##### Running clobber step. 23:41:27 INFO - ##### 23:41:27 INFO - Running pre-action listener: _resource_record_pre_action 23:41:27 INFO - Running main action method: clobber 23:41:27 INFO - rmtree: /builds/slave/test/build 23:41:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:41:28 INFO - Running post-action listener: _resource_record_post_action 23:41:28 INFO - ##### 23:41:28 INFO - ##### Finished clobber step (success) 23:41:28 INFO - ##### 23:41:28 INFO - ##### 23:41:28 INFO - ##### Running read-buildbot-config step. 23:41:28 INFO - ##### 23:41:28 INFO - Running pre-action listener: _resource_record_pre_action 23:41:28 INFO - Running main action method: read_buildbot_config 23:41:28 INFO - Using buildbot properties: 23:41:28 INFO - { 23:41:28 INFO - "project": "", 23:41:28 INFO - "product": "firefox", 23:41:28 INFO - "script_repo_revision": "production", 23:41:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:41:28 INFO - "repository": "", 23:41:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:41:28 INFO - "buildid": "20160608173003", 23:41:28 INFO - "pgo_build": "True", 23:41:28 INFO - "basedir": "/builds/slave/test", 23:41:28 INFO - "buildnumber": 171, 23:41:28 INFO - "slavename": "talos-linux64-ix-021", 23:41:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:41:28 INFO - "platform": "ubuntu64_hw", 23:41:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:41:28 INFO - "branch": "fx-team", 23:41:28 INFO - "repo_path": "integration/fx-team", 23:41:28 INFO - "revision": "8a447c89176fb240f78db350e8d65f62d0a6fabb", 23:41:28 INFO - "stage_platform": "linux64-pgo", 23:41:28 INFO - "builduid": "5409e863a65f46c7a617fd02e75a93b5", 23:41:28 INFO - "slavebuilddir": "test" 23:41:28 INFO - } 23:41:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:41:28 INFO - Running post-action listener: _resource_record_post_action 23:41:28 INFO - ##### 23:41:28 INFO - ##### Finished read-buildbot-config step (success) 23:41:28 INFO - ##### 23:41:28 INFO - ##### 23:41:28 INFO - ##### Running download-and-extract step. 23:41:28 INFO - ##### 23:41:28 INFO - Running pre-action listener: _resource_record_pre_action 23:41:28 INFO - Running main action method: download_and_extract 23:41:28 INFO - mkdir: /builds/slave/test/build/tests 23:41:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:28 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:41:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:41:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:41:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:41:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:41:40 INFO - Downloaded 1361 bytes. 23:41:40 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:41:40 INFO - Using the following test package requirements: 23:41:40 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:41:40 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:41:40 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:41:40 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'jsshell-linux-x86_64.zip'], 23:41:40 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:41:40 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:41:40 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:41:40 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:41:40 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:41:40 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:40 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:41:40 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:41:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:40 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:41:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:41:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:41:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:41:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:41:51 INFO - Downloaded 24451190 bytes. 23:41:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:41:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:41:53 INFO - Return code: 0 23:41:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:41: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')]} 23:41:53 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:41:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:41:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:41:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:41:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:41:54 INFO - Downloaded 24451190 bytes. 23:41:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:41:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:41:56 INFO - Return code: 0 23:41: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')]} 23:41:56 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:41:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:41:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:41:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:41:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:41:57 INFO - Downloaded 10833369 bytes. 23:41:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:41:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:41:57 INFO - Return code: 0 23:41: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')]} 23:41:57 INFO - https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:41:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:41:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:41:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:41:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:41:58 INFO - Downloaded 59327656 bytes. 23:41:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:41:58 INFO - mkdir: /builds/slave/test/properties 23:41:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:41:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:41:58 INFO - Contents: 23:41:58 INFO - build_url:https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:41:59 INFO - Running post-action listener: _resource_record_post_action 23:41:59 INFO - Running post-action listener: set_extra_try_arguments 23:41:59 INFO - ##### 23:41:59 INFO - ##### Finished download-and-extract step (success) 23:41:59 INFO - ##### 23:41:59 INFO - ##### 23:41:59 INFO - ##### Running populate-webroot step. 23:41:59 INFO - ##### 23:41:59 INFO - Running pre-action listener: _resource_record_pre_action 23:41:59 INFO - Running main action method: populate_webroot 23:41:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:41:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:41:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:41:59 INFO - '--tppagecycles', 23:41:59 INFO - '7'], 23:41:59 INFO - 'tests': ['tsvgm']}}, 23:41:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:41:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:41:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:41:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:41:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:41:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:41:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['damp', 'tps']}, 23:41:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'tests': ['damp', 'tps']}, 23:41:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['dromaeo_dom']}, 23:41:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:41:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['a11yr', 23:41:59 INFO - 'ts_paint', 23:41:59 INFO - 'tpaint', 23:41:59 INFO - 'sessionrestore', 23:41:59 INFO - 'sessionrestore_no_auto_restore', 23:41:59 INFO - 'tabpaint']}, 23:41:59 INFO - 'other-e10s': {'tests': ['a11yr', 23:41:59 INFO - 'ts_paint', 23:41:59 INFO - 'tpaint', 23:41:59 INFO - 'sessionrestore', 23:41:59 INFO - 'sessionrestore_no_auto_restore', 23:41:59 INFO - 'tabpaint']}, 23:41:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:41:59 INFO - 'ts_paint', 23:41:59 INFO - 'tpaint', 23:41:59 INFO - 'sessionrestore', 23:41:59 INFO - 'sessionrestore_no_auto_restore', 23:41:59 INFO - 'tabpaint']}, 23:41:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:41:59 INFO - 'ts_paint', 23:41:59 INFO - 'tpaint', 23:41:59 INFO - 'sessionrestore', 23:41:59 INFO - 'sessionrestore_no_auto_restore', 23:41:59 INFO - 'tabpaint']}, 23:41:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['a11yr', 23:41:59 INFO - 'ts_paint', 23:41:59 INFO - 'tpaint', 23:41:59 INFO - 'sessionrestore', 23:41:59 INFO - 'sessionrestore_no_auto_restore', 23:41:59 INFO - 'tabpaint']}, 23:41:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['a11yr', 23:41:59 INFO - 'ts_paint', 23:41:59 INFO - 'tpaint', 23:41:59 INFO - 'sessionrestore', 23:41:59 INFO - 'sessionrestore_no_auto_restore', 23:41:59 INFO - 'tabpaint']}, 23:41:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['tsvgx', 23:41:59 INFO - 'tsvgr_opacity', 23:41:59 INFO - 'tart', 23:41:59 INFO - 'tscrollx', 23:41:59 INFO - 'cart']}, 23:41:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:41:59 INFO - 'tsvgr_opacity', 23:41:59 INFO - 'tart', 23:41:59 INFO - 'tscrollx', 23:41:59 INFO - 'cart']}, 23:41:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'talos_options': ['--disable-e10s'], 23:41:59 INFO - 'tests': ['tp5o']}, 23:41:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'tests': ['tp5o']}, 23:41:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'talos_options': ['--disable-e10s', 23:41:59 INFO - '--xperf_path', 23:41:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:41:59 INFO - 'tests': ['tp5n']}, 23:41:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:59 INFO - 'talos_options': ['--xperf_path', 23:41:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:41:59 INFO - 'tests': ['tp5n']}}, 23:41:59 INFO - 'talos.zip': {'path': '', 23:41:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:41:59 INFO - Running post-action listener: _resource_record_post_action 23:41:59 INFO - ##### 23:41:59 INFO - ##### Finished populate-webroot step (success) 23:41:59 INFO - ##### 23:41:59 INFO - ##### 23:41:59 INFO - ##### Running create-virtualenv step. 23:41:59 INFO - ##### 23:41:59 INFO - Running pre-action listener: _resource_record_pre_action 23:41:59 INFO - Running main action method: create_virtualenv 23:41:59 INFO - Creating virtualenv /builds/slave/test/build/venv 23:41:59 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 23:41:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:41:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:41:59 INFO - Using real prefix '/usr' 23:41:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:42:00 INFO - Installing distribute.............................................................................................................................................................................................done. 23:42:02 INFO - Installing pip.................done. 23:42:02 INFO - Return code: 0 23:42:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:02 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:02 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 23:42:02 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 23:42:02 INFO - Using env: {'DISPLAY': ':0', 23:42:02 INFO - 'HOME': '/home/cltbld', 23:42:02 INFO - 'LANG': 'en_US.UTF-8', 23:42:02 INFO - 'LANGUAGE': 'en_US:en', 23:42:02 INFO - 'LOGNAME': 'cltbld', 23:42:02 INFO - 'MAIL': '/var/mail/cltbld', 23:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:02 INFO - 'MOZ_NO_REMOTE': '1', 23:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:02 INFO - 'NO_EM_RESTART': '1', 23:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:02 INFO - 'PWD': '/builds/slave/test', 23:42:02 INFO - 'SHELL': '/bin/bash', 23:42:02 INFO - 'SHLVL': '1', 23:42:02 INFO - 'TERM': 'linux', 23:42:02 INFO - 'TMOUT': '86400', 23:42:02 INFO - 'USER': 'cltbld', 23:42:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:02 INFO - '_': '/tools/buildbot/bin/python'} 23:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:02 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 23:42:02 INFO - Cleaning up... 23:42:02 INFO - Return code: 0 23:42:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:02 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:02 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 23:42:02 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 23:42:02 INFO - Using env: {'DISPLAY': ':0', 23:42:02 INFO - 'HOME': '/home/cltbld', 23:42:02 INFO - 'LANG': 'en_US.UTF-8', 23:42:02 INFO - 'LANGUAGE': 'en_US:en', 23:42:02 INFO - 'LOGNAME': 'cltbld', 23:42:02 INFO - 'MAIL': '/var/mail/cltbld', 23:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:02 INFO - 'MOZ_NO_REMOTE': '1', 23:42:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:02 INFO - 'NO_EM_RESTART': '1', 23:42:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:02 INFO - 'PWD': '/builds/slave/test', 23:42:02 INFO - 'SHELL': '/bin/bash', 23:42:02 INFO - 'SHLVL': '1', 23:42:02 INFO - 'TERM': 'linux', 23:42:02 INFO - 'TMOUT': '86400', 23:42:02 INFO - 'USER': 'cltbld', 23:42:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:02 INFO - '_': '/tools/buildbot/bin/python'} 23:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:02 INFO - Downloading/unpacking psutil>=3.1.1 23:42:02 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 23:42:02 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 23:42:02 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 23:42:02 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 23:42:02 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 23:42:02 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 23:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:42:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:04 INFO - Installing collected packages: psutil 23:42:04 INFO - Running setup.py install for psutil 23:42:04 INFO - building 'psutil._psutil_linux' extension 23:42:04 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 23:42:05 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 23:42:05 INFO - building 'psutil._psutil_posix' extension 23:42:05 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 23:42:05 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 23:42:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:05 INFO - Successfully installed psutil 23:42:05 INFO - Cleaning up... 23:42:05 INFO - Return code: 0 23:42:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:42:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:42:05 INFO - Using env: {'DISPLAY': ':0', 23:42:05 INFO - 'HOME': '/home/cltbld', 23:42:05 INFO - 'LANG': 'en_US.UTF-8', 23:42:05 INFO - 'LANGUAGE': 'en_US:en', 23:42:05 INFO - 'LOGNAME': 'cltbld', 23:42:05 INFO - 'MAIL': '/var/mail/cltbld', 23:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:05 INFO - 'MOZ_NO_REMOTE': '1', 23:42:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:05 INFO - 'NO_EM_RESTART': '1', 23:42:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:05 INFO - 'PWD': '/builds/slave/test', 23:42:05 INFO - 'SHELL': '/bin/bash', 23:42:05 INFO - 'SHLVL': '1', 23:42:05 INFO - 'TERM': 'linux', 23:42:05 INFO - 'TMOUT': '86400', 23:42:05 INFO - 'USER': 'cltbld', 23:42:05 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:05 INFO - '_': '/tools/buildbot/bin/python'} 23:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:42:05 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 23:42:05 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 23:42:05 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 23:42:05 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 23:42:05 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 23:42:05 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 23:42:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:42:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:42:07 INFO - Installing collected packages: mozsystemmonitor 23:42:07 INFO - Running setup.py install for mozsystemmonitor 23:42:07 INFO - Successfully installed mozsystemmonitor 23:42:07 INFO - Cleaning up... 23:42:07 INFO - Return code: 0 23:42:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:07 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:07 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 23:42:07 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 23:42:07 INFO - Using env: {'DISPLAY': ':0', 23:42:07 INFO - 'HOME': '/home/cltbld', 23:42:07 INFO - 'LANG': 'en_US.UTF-8', 23:42:07 INFO - 'LANGUAGE': 'en_US:en', 23:42:07 INFO - 'LOGNAME': 'cltbld', 23:42:07 INFO - 'MAIL': '/var/mail/cltbld', 23:42:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:07 INFO - 'MOZ_NO_REMOTE': '1', 23:42:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:07 INFO - 'NO_EM_RESTART': '1', 23:42:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:07 INFO - 'PWD': '/builds/slave/test', 23:42:07 INFO - 'SHELL': '/bin/bash', 23:42:07 INFO - 'SHLVL': '1', 23:42:07 INFO - 'TERM': 'linux', 23:42:07 INFO - 'TMOUT': '86400', 23:42:07 INFO - 'USER': 'cltbld', 23:42:07 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:07 INFO - '_': '/tools/buildbot/bin/python'} 23:42:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:07 INFO - Downloading/unpacking jsonschema==2.5.1 23:42:07 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 23:42:07 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 23:42:07 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 23:42:07 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 23:42:07 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 23:42:07 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 23:42:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:42:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:42:09 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 23:42:09 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 23:42:09 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 23:42:09 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 23:42:09 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 23:42:09 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 23:42:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:42:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:42:10 INFO - warning: no files found matching '*.txt' 23:42:10 INFO - no previously-included directories found matching 'build' 23:42:10 INFO - no previously-included directories found matching 'dist' 23:42:10 INFO - no previously-included directories found matching '.git*' 23:42:10 INFO - Installing collected packages: jsonschema, functools32 23:42:10 INFO - Running setup.py install for functools32 23:42:10 INFO - warning: no files found matching '*.txt' 23:42:10 INFO - no previously-included directories found matching 'build' 23:42:10 INFO - no previously-included directories found matching 'dist' 23:42:10 INFO - no previously-included directories found matching '.git*' 23:42:10 INFO - Successfully installed jsonschema functools32 23:42:10 INFO - Cleaning up... 23:42:10 INFO - Return code: 0 23:42:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:42:10 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')]} 23:42:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:10 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')]} 23:42:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:10 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:10 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 23:42:10 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 23:42:10 INFO - Using env: {'DISPLAY': ':0', 23:42:10 INFO - 'HOME': '/home/cltbld', 23:42:10 INFO - 'LANG': 'en_US.UTF-8', 23:42:10 INFO - 'LANGUAGE': 'en_US:en', 23:42:10 INFO - 'LOGNAME': 'cltbld', 23:42:10 INFO - 'MAIL': '/var/mail/cltbld', 23:42:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:10 INFO - 'MOZ_NO_REMOTE': '1', 23:42:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:10 INFO - 'NO_EM_RESTART': '1', 23:42:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:10 INFO - 'PWD': '/builds/slave/test', 23:42:10 INFO - 'SHELL': '/bin/bash', 23:42:10 INFO - 'SHLVL': '1', 23:42:10 INFO - 'TERM': 'linux', 23:42:10 INFO - 'TMOUT': '86400', 23:42:10 INFO - 'USER': 'cltbld', 23:42:10 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:10 INFO - '_': '/tools/buildbot/bin/python'} 23:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:42:10 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 23:42:10 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 23:42:10 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 23:42:10 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 23:42:10 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 23:42:10 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 23:42:12 INFO - Downloading blobuploader-1.2.4.tar.gz 23:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:42:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:42:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 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 23:42:12 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 23:42:13 INFO - Downloading docopt-0.6.1.tar.gz 23:42:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:42:13 INFO - Installing collected packages: blobuploader, requests, docopt 23:42:13 INFO - Running setup.py install for blobuploader 23:42:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:42:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:42:13 INFO - Running setup.py install for requests 23:42:13 INFO - Running setup.py install for docopt 23:42:13 INFO - Successfully installed blobuploader requests docopt 23:42:13 INFO - Cleaning up... 23:42:13 INFO - Return code: 0 23:42:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:13 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:13 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 23:42:13 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 23:42:13 INFO - Using env: {'DISPLAY': ':0', 23:42:13 INFO - 'HOME': '/home/cltbld', 23:42:13 INFO - 'LANG': 'en_US.UTF-8', 23:42:13 INFO - 'LANGUAGE': 'en_US:en', 23:42:13 INFO - 'LOGNAME': 'cltbld', 23:42:13 INFO - 'MAIL': '/var/mail/cltbld', 23:42:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:13 INFO - 'MOZ_NO_REMOTE': '1', 23:42:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:13 INFO - 'NO_EM_RESTART': '1', 23:42:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:13 INFO - 'PWD': '/builds/slave/test', 23:42:13 INFO - 'SHELL': '/bin/bash', 23:42:13 INFO - 'SHLVL': '1', 23:42:13 INFO - 'TERM': 'linux', 23:42:13 INFO - 'TMOUT': '86400', 23:42:13 INFO - 'USER': 'cltbld', 23:42:13 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:13 INFO - '_': '/tools/buildbot/bin/python'} 23:42:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:13 INFO - Running setup.py (path:/tmp/pip-hRka3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:14 INFO - Running setup.py (path:/tmp/pip-4F_pj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:14 INFO - Running setup.py (path:/tmp/pip-tXEj13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:14 INFO - Running setup.py (path:/tmp/pip-vDMI3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:14 INFO - Running setup.py (path:/tmp/pip-ZVAy2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:14 INFO - Running setup.py (path:/tmp/pip-FdXDD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:14 INFO - Running setup.py (path:/tmp/pip-GdM__U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:14 INFO - Running setup.py (path:/tmp/pip-86Tgf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:14 INFO - Running setup.py (path:/tmp/pip-hCTExO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:14 INFO - Running setup.py (path:/tmp/pip-Q4_myc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:14 INFO - Running setup.py (path:/tmp/pip-3Pb_DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:14 INFO - Running setup.py (path:/tmp/pip-2I6OW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:14 INFO - Running setup.py (path:/tmp/pip-m0h9Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:14 INFO - Running setup.py (path:/tmp/pip-F3deZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:14 INFO - Running setup.py (path:/tmp/pip-Mj1Cn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:15 INFO - Running setup.py (path:/tmp/pip-BJLEFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:15 INFO - Running setup.py (path:/tmp/pip-tYC_V0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:42:15 INFO - Running setup.py install for manifestparser 23:42:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozcrash 23:42:15 INFO - Running setup.py install for mozdebug 23:42:15 INFO - Running setup.py install for mozdevice 23:42:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozfile 23:42:15 INFO - Running setup.py install for mozhttpd 23:42:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozinfo 23:42:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozInstall 23:42:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozleak 23:42:16 INFO - Running setup.py install for mozlog 23:42:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Running setup.py install for moznetwork 23:42:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Running setup.py install for mozprocess 23:42:16 INFO - Running setup.py install for mozprofile 23:42:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Running setup.py install for mozrunner 23:42:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Running setup.py install for mozscreenshot 23:42:16 INFO - Running setup.py install for moztest 23:42:16 INFO - Running setup.py install for mozversion 23:42:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:42:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:42:16 INFO - Cleaning up... 23:42:16 INFO - Return code: 0 23:42:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42: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')]} 23:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42: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')]} 23:42:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:16 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:16 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 23:42:16 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 23:42:16 INFO - Using env: {'DISPLAY': ':0', 23:42:16 INFO - 'HOME': '/home/cltbld', 23:42:16 INFO - 'LANG': 'en_US.UTF-8', 23:42:16 INFO - 'LANGUAGE': 'en_US:en', 23:42:16 INFO - 'LOGNAME': 'cltbld', 23:42:16 INFO - 'MAIL': '/var/mail/cltbld', 23:42:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:16 INFO - 'MOZ_NO_REMOTE': '1', 23:42:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:16 INFO - 'NO_EM_RESTART': '1', 23:42:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:16 INFO - 'PWD': '/builds/slave/test', 23:42:16 INFO - 'SHELL': '/bin/bash', 23:42:16 INFO - 'SHLVL': '1', 23:42:16 INFO - 'TERM': 'linux', 23:42:16 INFO - 'TMOUT': '86400', 23:42:16 INFO - 'USER': 'cltbld', 23:42:16 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:16 INFO - '_': '/tools/buildbot/bin/python'} 23:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:17 INFO - Running setup.py (path:/tmp/pip-X7I89u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:17 INFO - Running setup.py (path:/tmp/pip-nwPFlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:17 INFO - Running setup.py (path:/tmp/pip-4VJc0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:17 INFO - Running setup.py (path:/tmp/pip-kvsHmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:17 INFO - Running setup.py (path:/tmp/pip-T_9lOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:17 INFO - Running setup.py (path:/tmp/pip-GOT1S2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:17 INFO - Running setup.py (path:/tmp/pip-MurlZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:17 INFO - Running setup.py (path:/tmp/pip-gmwt1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:17 INFO - Running setup.py (path:/tmp/pip-bv26XL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:17 INFO - Running setup.py (path:/tmp/pip-gRiGZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:17 INFO - Running setup.py (path:/tmp/pip-GetDp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:17 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)) 23:42:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:17 INFO - Running setup.py (path:/tmp/pip-gax21k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:18 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)) 23:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:18 INFO - Running setup.py (path:/tmp/pip-rT1UQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:18 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)) 23:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:18 INFO - Running setup.py (path:/tmp/pip-GGp_Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:18 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)) 23:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:18 INFO - Running setup.py (path:/tmp/pip-X3EH84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:18 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)) 23:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:18 INFO - Running setup.py (path:/tmp/pip-lfbBrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:18 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)) 23:42:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:18 INFO - Running setup.py (path:/tmp/pip-0K8Iki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:18 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)) 23:42:18 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)) 23:42:18 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)) 23:42:18 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)) 23:42:18 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)) 23:42:18 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)) 23:42:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:42:18 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 23:42:18 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 23:42:18 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 23:42:18 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 23:42:18 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 23:42:18 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 23:42:20 INFO - Downloading blessings-1.6.tar.gz 23:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:42:20 INFO - Installing collected packages: blessings 23:42:20 INFO - Running setup.py install for blessings 23:42:20 INFO - Successfully installed blessings 23:42:20 INFO - Cleaning up... 23:42:20 INFO - Return code: 0 23:42:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:42:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:20 INFO - Reading from file tmpfile_stdout 23:42:20 INFO - Current package versions: 23:42:20 INFO - argparse == 1.2.1 23:42:20 INFO - blessings == 1.6 23:42:20 INFO - blobuploader == 1.2.4 23:42:20 INFO - docopt == 0.6.1 23:42:20 INFO - functools32 == 3.2.3-2 23:42:20 INFO - jsonschema == 2.5.1 23:42:20 INFO - manifestparser == 1.1 23:42:20 INFO - mozInstall == 1.12 23:42:20 INFO - mozcrash == 0.17 23:42:20 INFO - mozdebug == 0.1 23:42:20 INFO - mozdevice == 0.48 23:42:20 INFO - mozfile == 1.2 23:42:20 INFO - mozhttpd == 0.7 23:42:20 INFO - mozinfo == 0.9 23:42:20 INFO - mozleak == 0.1 23:42:20 INFO - mozlog == 3.2 23:42:20 INFO - moznetwork == 0.27 23:42:20 INFO - mozprocess == 0.22 23:42:20 INFO - mozprofile == 0.28 23:42:20 INFO - mozrunner == 6.11 23:42:20 INFO - mozscreenshot == 0.1 23:42:20 INFO - mozsystemmonitor == 0.3 23:42:20 INFO - moztest == 0.7 23:42:20 INFO - mozversion == 1.4 23:42:20 INFO - psutil == 3.1.1 23:42:20 INFO - requests == 1.2.3 23:42:20 INFO - wsgiref == 0.1.2 23:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42: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')]} 23:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42: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')]} 23:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:20 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 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:20 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 23:42:20 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 23:42:20 INFO - Using env: {'DISPLAY': ':0', 23:42:20 INFO - 'HOME': '/home/cltbld', 23:42:20 INFO - 'LANG': 'en_US.UTF-8', 23:42:20 INFO - 'LANGUAGE': 'en_US:en', 23:42:20 INFO - 'LOGNAME': 'cltbld', 23:42:20 INFO - 'MAIL': '/var/mail/cltbld', 23:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:20 INFO - 'MOZ_NO_REMOTE': '1', 23:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:20 INFO - 'NO_EM_RESTART': '1', 23:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:20 INFO - 'PWD': '/builds/slave/test', 23:42:20 INFO - 'SHELL': '/bin/bash', 23:42:20 INFO - 'SHLVL': '1', 23:42:20 INFO - 'TERM': 'linux', 23:42:20 INFO - 'TMOUT': '86400', 23:42:20 INFO - 'USER': 'cltbld', 23:42:20 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:20 INFO - '_': '/tools/buildbot/bin/python'} 23:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 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)) 23:42:20 INFO - Cleaning up... 23:42:21 INFO - Return code: 0 23:42:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:42:21 INFO - Using env: {'DISPLAY': ':0', 23:42:21 INFO - 'HOME': '/home/cltbld', 23:42:21 INFO - 'LANG': 'en_US.UTF-8', 23:42:21 INFO - 'LANGUAGE': 'en_US:en', 23:42:21 INFO - 'LOGNAME': 'cltbld', 23:42:21 INFO - 'MAIL': '/var/mail/cltbld', 23:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:21 INFO - 'MOZ_NO_REMOTE': '1', 23:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:21 INFO - 'NO_EM_RESTART': '1', 23:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:21 INFO - 'PWD': '/builds/slave/test', 23:42:21 INFO - 'SHELL': '/bin/bash', 23:42:21 INFO - 'SHLVL': '1', 23:42:21 INFO - 'TERM': 'linux', 23:42:21 INFO - 'TMOUT': '86400', 23:42:21 INFO - 'USER': 'cltbld', 23:42:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:21 INFO - '_': '/tools/buildbot/bin/python'} 23:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:42:21 INFO - Cleaning up... 23:42:21 INFO - Return code: 0 23:42:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0da75aef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2464350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, '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': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', '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 23:42:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:42:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:42:21 INFO - Using env: {'DISPLAY': ':0', 23:42:21 INFO - 'HOME': '/home/cltbld', 23:42:21 INFO - 'LANG': 'en_US.UTF-8', 23:42:21 INFO - 'LANGUAGE': 'en_US:en', 23:42:21 INFO - 'LOGNAME': 'cltbld', 23:42:21 INFO - 'MAIL': '/var/mail/cltbld', 23:42:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:21 INFO - 'MOZ_NO_REMOTE': '1', 23:42:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:21 INFO - 'NO_EM_RESTART': '1', 23:42:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:21 INFO - 'PWD': '/builds/slave/test', 23:42:21 INFO - 'SHELL': '/bin/bash', 23:42:21 INFO - 'SHLVL': '1', 23:42:21 INFO - 'TERM': 'linux', 23:42:21 INFO - 'TMOUT': '86400', 23:42:21 INFO - 'USER': 'cltbld', 23:42:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:21 INFO - '_': '/tools/buildbot/bin/python'} 23:42:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:21 INFO - Downloading/unpacking flake8 23:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:42:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:42:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:42:24 INFO - no previously-included directories found matching 'docs/_build' 23:42:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:42:24 INFO - Running setup.py install for pep8 23:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:42:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:42:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:42:24 INFO - no previously-included directories found matching 'docs/_build' 23:42:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:42:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:42:24 INFO - Cleaning up... 23:42:24 INFO - Return code: 0 23:42:24 INFO - Running post-action listener: _resource_record_post_action 23:42:24 INFO - Running post-action listener: _start_resource_monitoring 23:42:24 INFO - Starting resource monitoring. 23:42:24 INFO - ##### 23:42:24 INFO - ##### Finished create-virtualenv step (success) 23:42:24 INFO - ##### 23:42:24 INFO - ##### 23:42:24 INFO - ##### Running install step. 23:42:24 INFO - ##### 23:42:24 INFO - Running pre-action listener: _resource_record_pre_action 23:42:24 INFO - Running main action method: install 23:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:24 INFO - Reading from file tmpfile_stdout 23:42:24 INFO - Detecting whether we're running mozinstall >=1.0... 23:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:42:24 INFO - Reading from file tmpfile_stdout 23:42:24 INFO - Output received: 23:42:24 INFO - Usage: mozinstall [options] installer 23:42:24 INFO - Options: 23:42:24 INFO - -h, --help show this help message and exit 23:42:24 INFO - -d DEST, --destination=DEST 23:42:24 INFO - Directory to install application into. [default: 23:42:24 INFO - "/builds/slave/test"] 23:42:24 INFO - --app=APP Application being installed. [default: firefox] 23:42:24 INFO - mkdir: /builds/slave/test/build/application 23:42:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:42:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:42:42 INFO - Reading from file tmpfile_stdout 23:42:42 INFO - Output received: 23:42:42 INFO - /builds/slave/test/build/application/firefox/firefox 23:42:42 INFO - Running post-action listener: _resource_record_post_action 23:42:42 INFO - ##### 23:42:42 INFO - ##### Finished install step (success) 23:42:42 INFO - ##### 23:42:42 INFO - ##### 23:42:42 INFO - ##### Running run-tests step. 23:42:42 INFO - ##### 23:42:42 INFO - Running pre-action listener: _resource_record_pre_action 23:42:42 INFO - Running main action method: run_tests 23:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:42:42 INFO - Python 2.7.3 23:42:42 INFO - Return code: 0 23:42:42 INFO - grabbing minidump binary from tooltool 23:42:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:42 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 0x24f31c0>, '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 0x24f40c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24f4550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:42:42 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 23:42:42 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 23:42:42 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 23:42:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:42:42 INFO - Return code: 0 23:42:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:42:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:42:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:42:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:42:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:42:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:42:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:42:43 INFO - Return code: 0 23:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 23:42:43 INFO - Using env: {'DISPLAY': ':0', 23:42:43 INFO - 'HOME': '/home/cltbld', 23:42:43 INFO - 'LANG': 'en_US.UTF-8', 23:42:43 INFO - 'LANGUAGE': 'en_US:en', 23:42:43 INFO - 'LOGNAME': 'cltbld', 23:42:43 INFO - 'MAIL': '/var/mail/cltbld', 23:42:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:42:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:43 INFO - 'MOZ_NO_REMOTE': '1', 23:42:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:43 INFO - 'NO_EM_RESTART': '1', 23:42:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:43 INFO - 'PWD': '/builds/slave/test', 23:42:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:42:43 INFO - 'SHELL': '/bin/bash', 23:42:43 INFO - 'SHLVL': '1', 23:42:43 INFO - 'TERM': 'linux', 23:42:43 INFO - 'TMOUT': '86400', 23:42:43 INFO - 'USER': 'cltbld', 23:42:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376', 23:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:43 INFO - '_': '/tools/buildbot/bin/python'} 23:42:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:42:43 INFO - mozversion application_buildid: 20160608173003 23:42:43 INFO - mozversion application_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:42:43 INFO - mozversion application_display_name: Nightly 23:42:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:42:43 INFO - mozversion application_name: Firefox 23:42:43 INFO - mozversion application_remotingname: firefox 23:42:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:42:43 INFO - mozversion application_vendor: Mozilla 23:42:43 INFO - mozversion application_version: 50.0a1 23:42:43 INFO - mozversion platform_buildid: 20160608173003 23:42:43 INFO - mozversion platform_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:42:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:42:43 INFO - mozversion platform_version: 50.0a1 23:42:43 INFO - using testdate: 1465454563 23:42:43 INFO - actual date: 1465454563 23:42:43 INFO - starting webserver on 'localhost:55931' 23:42:43 INFO - SUITE-START | Running 2 tests 23:42:43 INFO - TEST-START | dromaeo_css 23:42:43 INFO - operating with platform_type : linux_ 23:42:43 INFO - Initialising browser for dromaeo_css test... 23:42:43 INFO - TEST-INFO | started process 1577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3m_kDp/profile http://localhost:55931/getInfo.html) 23:42:47 INFO - PROCESS | 1577 | __metrics Screen width/height:1600/1200 23:42:47 INFO - PROCESS | 1577 | colorDepth:24 23:42:47 INFO - PROCESS | 1577 | Browser inner width/height: 1024/697 23:42:47 INFO - PROCESS | 1577 | __metrics 23:42:49 ERROR - PROCESS | 1577 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:42:49 INFO - PROCESS | 1577 | console.error: PushService: 23:42:49 INFO - PROCESS | 1577 | stateChangeProcessEnqueue: Error transitioning state 23:42:49 INFO - PROCESS | 1577 | UnknownError 23:42:50 INFO - TEST-INFO | 1577: exit 0 23:42:50 INFO - Browser initialized. 23:42:50 INFO - Running cycle 1/1 for dromaeo_css test... 23:42:50 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3m_kDp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:01 INFO - PROCESS | 1662 | RSS: Main: 160276480 23:43:01 INFO - PROCESS | 1662 | 23:43:53 INFO - PROCESS | 1662 | 1465454633124 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] 23:46:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55931/tests/dromaeo/cssquery-ext.html) 23:46:02 INFO - PROCESS | 1662 | RSS: Main: 270348288 23:46:02 INFO - PROCESS | 1662 | 23:49:04 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-ext.html (next: http://localhost:55931/tests/dromaeo/cssquery-jquery.html) 23:49:05 INFO - PROCESS | 1662 | RSS: Main: 244633600 23:49:05 INFO - PROCESS | 1662 | 23:52:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55931/tests/dromaeo/cssquery-mootools.html) 23:52:07 INFO - PROCESS | 1662 | RSS: Main: 246026240 23:52:07 INFO - PROCESS | 1662 | 23:55:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55931/tests/dromaeo/cssquery-prototype.html) 23:55:10 INFO - PROCESS | 1662 | RSS: Main: 244219904 23:55:10 INFO - PROCESS | 1662 | 23:58:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55931/tests/dromaeo/cssquery-yui.html) 23:58:13 INFO - PROCESS | 1662 | RSS: Main: 221089792 23:58:13 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:55931/tests/dromaeo/cssquery-yui.html (next: http://localhost:55931/tests/dromaeo/cssquery-dojo.html) 00:01:16 INFO - PROCESS | 1662 | RSS: Main: 277254144 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | __start_tp_report 00:01:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 00:01:16 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 00:01:16 INFO - PROCESS | 1662 | |i|pagename|runs| 00:01:16 INFO - PROCESS | 1662 | |0;dojo.html;3082.306481041766;3091.8608662610195;3113.922151946201;3133.169710026842;3156.636986746525;5099.974500127503;5184.792608295673;5201.7919283228675;5254.106801843686;5283.2075188721665;5231.686098834072;5239.240310155025;5250.684958902469;5255.579553635709;5305.681659100456;4711.528847115295;4781.856544303659;4785.641076919228;4791.113643975876;4984.352034235562;4911.115999120157;4936.531029552187;4968.105740966625;4971.825986090487;4983.327250821129;4687.039156972813;4711.693739906895;4766.332713420124;4851.223804191348;4870.342503761982;4729.337892695025;4742.881427964294;4748.07412554552;4762;4823.975880120612;4757.976210118962;4762.690425122356;4765.880852978668;4769.1177132230305;4780.665353425262;5024.773885175139;5103.642745007851;5201.375834899798;5206.7917283308625;5212.166053431471;5591.384947655754;5635.718214089279;5646.237757902672;5664.150377443375;5668.121441176624;5641.407652196502;5647.350554686182;5674.829755107354;5693.743781529841;5696.743646535916;5144.43411224765;5206.323177986837;5209.531142197183;5279.102552565996;5283.894322113575;5754.395788442237;5759.596828222068;5778.36437991829;5837.445442682938;5849.356570777211;5563.944360556424;5604.131359639263;5606.775728970877;5612.85967850807;5619.185218143346;5569.303837020372;5681.9431805681415;5697.116946873241;5699.059655156935;5703.515201207943;5464.23500709901;5504.339479262434;5585.162225666101;5598.888022239533;5634.126710359901;5531.612787104945;5535.861603459865;5546.195801608825;5549.916751248654;5552.750126244328;4273;4285.828566857291;4288.656907447396;4292.227399068198;4323.610875021201;3796.126890815128;3827.827747751358;3879.553851307136;3881.029742564359;3881.86413475527;5355.410904800468;5356.491133342404;5357.732113394315;5361.329833770778;5392.460753924576;5688.345840228344;5689.459501347365;5695.430456954271;5722.284714410699;5760.971195143998;5198.116320225571;5269.736513174403;5297.231901374356;5325.201219817059;5352.839414817562;4816.133096042746;4850.660453768273;4901.779419926112;4903.53416425439;4946.851594452172;5553.08374118266;5797.594168408255;5825.155352473952;5836.387179346192;5859.150423188614;5606.887862242814;5651.802186923438;5653.915191272052;5686.2607860977805;5702.51528620072;5832.708364581669;5840.240768700041;5858.091995740667;5869.266341707286;5875.294964604275;5412.810551630674;5510.338759348904;5561.721913904208;5565.944340556543;5573.136163894603;5616.522595579421;5709.029464990878;5709.8287051388525;5712.742926568398;5767.048437007847;5528.668279903219;5543.251661025871;5544;5544.390117087198;5544.473275038865;5298.6290959634;5416.7562459688625;5469.425710300361;5553.333599968029;5571.9721401392735;5424.891502170013;5435.646682965595;5435.673859568438;5438.945610543844;5452.291202143696;5520.751566179451;5548.029094908295;5609.074502707171;5609.719514024364;5610.5231055360755;5219.947800521946;5331.733413329395;5385.8114965976;5394.541463975449;5421.888512854776 00:01:16 INFO - PROCESS | 1662 | |1;ext.html;547.2229434203431;603.592575011867;612.4793925163611;613.8005148326793;633.4045996763045;32423.51364729528;45303.546964530346;46545.767271163684;46672.76663616677;46693.06613867725;48225.27662085072;48360;48494.27258591124;48736.75631621837;48781.51218487814;8686.999999999984;8818.20636142747;8833.779155521099;8844.469331840079;8846.02693703692;8785.692500762474;8847.247983921343;8857.335699822506;8859.601317940707;8860.424072435271;8813.074627164151;8900.554972251393;8928.973168085688;8969.103089691043;8974.910250897472;8829.514376709278;8853.513056781874;8862.86705699415;8873.866891996626;8877.644894204224;8786.253168480687;8854.29165666745;8854.468731876044;8859.601317940707;8860.291176705912;43475.13049739019;43528.56471435277;43718.56281437177;43766;43816;3678.411454167347;3721.9441708374397;3790.7915064671433;4071.5928407159345;4288.16380805743;32950;33485.665143348495;33580.83209583961;34416.13959651004;34800;3733.4213196954515;3757.6618104370737;3836.079340958178;3870.4968354114067;3919.7648141111627;362262;362467;363231;363385;363592;54472.45527544753;60197.69901150554;60226;60502.69748651316;60685.08972365418;68101.65949170322;70286;70530.64734676294;70579.64710176416;70605.2939470609;16846.07346595949;16850.915745421193;16856.07291598974;16871.831281687028;16883;10316;12095.213811102427;12205.511779528897;12253.081018923616;13046.608601741962;18311.450656480327;18824.529386765167;19144.234230630896;19181.273685368385;19230.423087307405;5712.257761382735;5901.380355062656;5953.315368732565;6014.609050411709;6067.575269731076;911.2664305234217;1029.8712660917386;1082.6643740440488;1135.5968631135993;1193;33004;33130;33131.66868331334;33245.335093297996;33636.1590960228;1117.8043842327722;1123.4496394974883;1161.703765539782;1201.1111777284746;1226.2948804437485;17485.30058797659;17531.032979661326;17752.644947100987;17761.200745966464;17984.190711418018;541100;543439;546981;547063;549012.3339516186;60730.69634651799;60827.39172608306;60880;60915.39084609186;61055.38944610586;1272.7963525836008;1326.7014921642553;1352.3508715816267;1398.8391334996402;1417.2417756500222;32689.836550818047;34031.476273114386;34361.140971475914;34552.48171277383;34872.30255394929;51885.48114518807;52305.47694523006;52413.7379313101;52524.474755251955;52526.21210681919;421820;422560;422609;422679;422790;34001.48997765085;39046.80476597599;39273.214535709696;43209.35185972276;44196;49430.50569494259;49451.752741236065;49668;50068.742782007364;51114.488855110976;42217.57782422259;42229.78885105555;43186.56813431825;43626.78186609047;44060.779696101315;41505;41791.746247612624;42047.15905681808;42654.146917062106;42918;42057;42584.57415425806;42991.785041074596;43051.784741076095;43407;36479.27041459103;36963.63036369709;37703;38561.614383856926;38597.80701096477;26626.866865665546;28998.11512251697;29235.415291694473;29345.266368340963;29407.26481837971 00:01:16 INFO - PROCESS | 1662 | |2;jquery.html;371.92561487702466;373.3298728781836;381.8129116732801;383.94048922417034;395.86144849302747;17816.82183178168;19598.90200548999;19860.50348741282;20621.17515299388;20629.896850515765;18572.907135464302;18746.71879921799;18759.591679125508;19047.809521904775;19184.23263069479;5460.726963651811;5551.250581171531;5710.457506536873;5718.628289161212;5729.627574207684;5501.202325662796;5582.637128586629;5591.860203494904;5632.915506267389;5660.462256085686;5486.3690675572225;5546.750396232179;5580.665160090387;5586.720663966806;5598.832035038935;5445.673259604397;5569.693666848321;5573.27547418837;5584.581156413265;5643.802466913679;4851.369321988154;4959.578435832958;4965.131102057126;5050.141475949097;5054.620903432257;22488;22753.77246227533;22829;22974.310770676908;22989.425264368358;2349.2130136404326;2366.337425520857;2382.833201675883;2394.0663141374703;2587.637730717701;13882.514112006133;14235.217063061527;14386.280685965765;14513.854861451357;14589;1907.12272354717;1967.6359873423462;2025.8581899267058;2053.9897300513403;2061.494933741243;77584.61207693926;78188.60905695493;78866;79499.99999999942;81199.59400203021;9989.550470228856;10032.64885728996;10354.275200736027;10387;10528.684139475828;13636;13711.040227184201;13724.107932984523;13770.724585508233;13776.793348099787;7924.247196516321;8095.55474448911;8109.918900811034;8268.421210515206;8295.419320647617;7954.721584744506;8087.1912808719835;8091.514509129471;8109.797255068553;8362.498250105013;6381.266154392304;6414.61512309263;6430.260520040161;6476.676166191672;6494.480441564663;1700.6768713944311;1795.8293962073583;1811.900345480985;1812.238859678938;1837.0814592703648;980.519545422752;1007.4559737741538;1007.9949600251952;1053.8840727519967;1062.940935091387;18536.351227706964;19343;19386.321478748177;19448.319308824124;19841.206351746056;1038.8078205532001;1055.4986381468893;1056.1603525197486;1071.6838532632892;1130.7286251299793;8261.669533218605;11288.322700637824;11317.71705707364;11341.319520828776;11341.829872551918;470619;473739.4695397859;478526;489956;490849;76316.61841690868;78123.60938195273;79985;80062.59968700235;80512;1018.1854516386861;1020.4489575629077;1042.9322094063862;1050.2280823594651;1061.2518174686827;16634;16780.496585102468;17124.14379281056;17235.22441490111;17714.91142544279;36543.26913461769;36628.816855916615;36824;37277.25445491021;38053.42919856149;48233;50518;51604;52202;52490.212646811095;8098.3926205536;8467.53428561435;8641.351898607503;8678.696245631372;8823.117688231383;13156.144850584682;13305.268210248529;13328.33358332099;13451.394687238902;13659.180449173082;11593.130515211224;11691.181617286707;11777.35224562623;11872.287662740264;12018.939905300418;11278.266912650652;11348.943255283672;11557.942210288895;11769.52921883115;11861.881381186078;11785.292882427082;11805.940970295094;11865.228760130563;11969.760604787682;12066.698332541757;7363.926360736324;7609.391248700202;7689.577073261024;8057.798555036171;8552.315814734682;10992.28550144238;11708.063354931415;11843.348615826213;11864.762704745684;12043.578474753342 00:01:16 INFO - PROCESS | 1662 | |3;mootools.html;1351.6553278913875;1504.6012806606248;1540.0143907898944;1654.8179700232972;1811.7644706188194;8350.958245208772;8714.651413943442;8716.694915677945;8930.866037009433;8933.062028487013;8659.91340086599;8860.645574177026;8874.378793484459;8881.822363552725;8887.28901687865;2018.495376155961;2072.450800537859;2075.782042885498;2293.8738369389716;2325.3140323604575;2312.6646636237733;2390.6294524348755;2392.3301475586863;2404.0984630763464;2406.9638955415685;2252.054137262354;2279.0200213908015;2299.9195028174017;2300.459392042869;2302.7236731592147;2013.8489613278916;2239.2050821958296;2305.9308220753405;2344.4490544721975;2344.9179278725246;2334.4514039200776;2368.715754109518;2370.608849539824;2372.5373552157334;2373.6795532603223;8666.090060543678;8743.650253989832;8747.606357713918;8748.212660860552;8765.474071555727;5083.364579427572;5223.059849227137;5223.660462069954;5229;5230.529252367305;3154.794938329001;3191.6329622093526;3368.073779710575;3381.746369022333;3389.813565252142;1084.967450976472;1087.472575800736;1097.040089921319;1099.2964502718266;1106.1758989552834;12167.391630418444;12332.260064396165;12334.074944379208;12348;12363.443645036084;4593.954060459353;4667.486576476585;4695.7886895089805;4715.858524244278;4738.099761045391;10399.376037437778;10403.53184106717;10408.427536485566;10411.94794026025;10427.895721042843;5225.6603320784025;5300.1519756838725;5302.973485132549;5304.655197412233;5306.8407947761625;4137.50349958001;4694.859154225379;4820.30105634681;4883.4628190898975;4891.926621100686;3899.5515515715488;3938.680542018456;3961.643452089326;4021.6983726220064;4051.453053837753;1207.4868181023205;1209.5766481731323;1226.2826246645811;1230.6000549821345;1239.9380030998595;1004.5780772075746;1004.8392257238806;1016.537475448669;1018.6434747838346;1020.4438580973388;5785.363610002896;5904.380040095814;5987.221661184019;6153.323134455206;6156.8768624627255;427.4293817753272;431.5016156339433;433.3002201444707;436.46968932746864;438.1150076844756;4049.190161967618;4097.405876147942;4097.97951010243;4104.958950410517;4124.381342798604;10446;10609.628662996758;10719.946400267949;10815.945920270347;10823.296485728402;10441.68674939753;10620.522076506575;10640.733981650521;10694.465276736131;10756.78486430267;8209.09699933007;8247.793805154919;8273;8282.378821588405;8297.419180657296;5890.14592884038;5906.438888305604;5923;5976.342602313829;6005.309389420097;9758.414495130315;10087.142592879394;10181.796364072825;10188.439635819805;10192.592296308065;9912;10099.596016159565;10121.240906932157;10125.59497620087;10253.128484078938;7118;7339.486235963432;7521.360684341674;7871.291583757489;7938.801529961797;8342.83314333722;8427.157284271523;8428.157184281523;8429.030661473764;8455.11221321777;7409.518381305414;7569.772906812805;7613.885791713018;7617.5048621839405;7657.502262352929;7322;7511.812204694927;7528.774136775905;7639.923600763921;7665.386769058574;6689.431398331002;6722.764703235559;6757.628330441873;6759.357861003196;6760.628165450751;4836.371271734652;5021.3472248608905;5118.616103792305;5150.356205474316;5172.689638621695;4624.1445332613575;5067.366579177603;5115.948840511696;5187.19598462239;5191.273221748883 00:01:16 INFO - PROCESS | 1662 | |4;prototype.html;320.3033402349889;321.33644025088194;327.3191761136835;329.25588170734136;329.98020118792874;5248.186531087683;5248.212768084789;5261.3949395819445;5265.631405801595;5273.920891186631;5221.624161006743;5248.71132087735;5248.897731476385;5256.106461901476;5264.157734762429;3851.5185601799776;3934.291827471047;4073.490813648294;4092.0358228050404;4105.897352566195;4108.958910410887;4116.75299482032;4117.752934823905;4124.690648201382;4153.563875793044;4048.898777530556;4098.159877225176;4099.7745124018165;4109.732867363627;4126.195391898581;4037.0311125330004;4112.3625837995005;4130.855420060314;4136.31750761124;4136.945079004865;3628.673419392241;3659.9634003660153;3662.981685091584;3668.779873207616;3681.7606855554304;5066.847994560169;5126.333576635051;5132.948670513321;5133.048497114174;5151.094095184768;4606.746628935407;4712.717236965793;4728.172569800306;4735.57379835813;4754.477007529169;5417.160340147283;5449.782008719647;5497.532709719679;5516.8966206758805;5530.557555395559;3972.106276087886;3978.124812541236;4013.4180543821276;4017.397390391465;4026.939595906064;5558.0269004503625;5647.971760141214;5667.234923285386;5774.740136693817;5789.594728369016;4043.6562892154498;4059.594040595976;4066.6340029397497;4071.4096456014304;4073.918521629551;4104.548499665035;4110.547839737626;4129.29801933672;4132.896677583084;4135.359019352005;4388.29787234041;4662.230731929261;4682.953170468251;4692.7653617319;4732.361131247307;5440.231924624433;5503.972480137573;5530.5022547970875;5567;5581.576697941999;1371.163590209971;1383.3359987206197;1389.215093472185;1398.9927252378272;1401.2923473645744;895.1183084661603;902.9593668284942;903.074348792493;906.5240748607034;936.5738588942015;5195.2986346843445;5226.529612334832;5254.789808407697;5274.736263186825;5303.178007408857;5526.281583394133;5561.721913904288;5566.526845218121;5571.220029195916;5571.9721401392735;5153.330067091254;5272.657277276965;5273.367195936436;5273.367195936512;5287.576993840484;2930.2527855397166;2938.691437399085;2947.2779169103705;2952.512835382181;2964.8072875263038;5664.320281566238;5678.858028549319;5696.772129114789;5699.31870098322;5707.771689132472;5384.596155288291;5610;5697.886042279214;5730.627509211888;5732.570057245724;5665.433456654384;5674.517665998354;5689.516391106802;5718.542516598662;5758.510526605285;5292.914952434665;5579.386267510652;5595.916061259003;5609.13933893709;5650;5611.8877622448135;5646.237757902631;5650.57620678459;5662.971685141548;5673.886522269614;5825.126231065374;5827.475527202572;5833.445822646841;5844.883102338014;5866.472017518444;3929.0499648836453;3961.643452089326;4006.719529633014;4015.096603264359;4039;5547.472990065938;5744;5763.33721622002;5791.8552036199435;5814;5650.180723794944;5655.349634792052;5670.914936275876;5683.857903552444;5688.40271771458;5282.260483532232;5518.951399234133;5524.502794748492;5538.196961440488;5541.224228608079;5190.870228244324;5383.7308134593895;5421.810236641699;5438.972805135949;5452.236686863922;5355.500459871242;5517.7033397150835;5517.806876759294;5533.391326953952;5595.776168953359;5433.347998240237;5437.755301011385;5443.210734443563;5455.345358556999;5466.8906621866545 00:01:16 INFO - PROCESS | 1662 | |5;yui.html;786.7246463737692;792.9841403171937;810.1817164663692;829.108708138751;838.1576515601821;14430.927845360771;15433.45982890599;15747.842521574781;16223.75664365034;16269.51191464255;13452.865471345283;13471.461141554326;13604.659883502918;13607.387667554958;13625.863741362584;698.8183072401162;814.1898810683379;823.1028179284564;836.9665213391457;840.4579046514995;833.7998880268752;834.2616784146044;836.5524444422235;837.7319257837495;837.9162083791633;863.1541089732067;869.5739087846941;869.74342568942;870.4168207301092;871.2072014466836;724.4747558020446;740.6815069520131;845.2055068235838;866.9133086691312;869.4131461263622;636.2555809702659;636.4081404294004;636.535329209675;636.5830381100386;636.723025483916;14126.505572305023;14126.788098178535;14139.293035348293;14141.575752727435;14158.079724817853;14201.928990354982;14478.348474318682;14521.419143234258;14568.271586420742;14574.562763117123;12110.320107532252;12348.814767778491;12399.876001239962;12506.124571279923;12513.687157821036;4391.6267117295065;4478.708883922567;4532.9546704533195;4642.930356044662;4644.651651126179;71568.2843171572;72203.99999999948;72563.63718181428;72689;72703.27296727018;10362.689119326433;10506.894931050592;10537;10735.194860385345;10970.616028439126;20909.108918736925;21292.25477108294;21303.893480532497;21329.360119196448;21679.891600541898;8354.206350396702;8358.665653373919;8509.446885952393;8516.318694504425;8669.826603467895;4431.911361772746;4596.609288210473;4638.652101092432;4681.274402467623;4821.951780482221;3531.6644918732677;3698.8705395311035;3702.500162478085;3704.1665625234104;3707.1102935295876;590.0470739755265;593.1073734030257;600.7506884642912;602.2411761180856;602.7739597650881;686.1800148822209;688.5283580747205;692.8246002362346;697.6197972105215;705.4427002667937;9254;9470.573824177929;9667.226621870233;9690.56392462341;9776.315657903879;584.2784161560469;617.1822335405606;624.7750809708501;626.5614070150913;635.7266375458505;4501.909961800746;4540.205464043779;4567.703099298601;4620.976895115503;4659.720416775004;69251.30748692449;86794.56602716947;106493.46753266185;109723.45138274417;112639;96191;96890.5155474218;98041;98948.5052574747;99043;82432;82512.58743706244;82806;85050;85459.14540854511;8702.782430439289;8814.823703525766;8848.91151088481;8887.955560222157;8897.199252067345;43004.78497607617;43376.56623433851;45783.54216457793;52000.73999629977;53514.73242633762;71202.28797712164;71365;72168.27831721616;72416.6379168122;72819.27180728124;12564.623061308175;12584.307863067253;12793.040521961077;12844.422001010164;13154.013448991554;14481.85518144805;15143.199281508743;15178.772318415453;15526.767098493758;15733.134677592841;14148.504802331869;14227.786583201054;14536.709265814836;14577.635559111108;15103.848961510685;14197.971860054276;14382.28088595587;14545.272736363351;14597.270136493345;14631.92684036573;13777.448902043807;13783.310834458036;13874.167549947035;14093.365798538885;14189.503367382093;11073.280236784905;11482.852552909102;11915.82126268124;12041.819372709591;12095.818562721743;11351.602693905674;11702.967723878473;11865.525378984745;12247;12257 00:01:16 INFO - PROCESS | 1662 | __end_tp_report 00:01:16 INFO - PROCESS | 1662 | __start_cc_report 00:01:16 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1025 00:01:16 INFO - PROCESS | 1662 | __end_cc_report 00:01:16 INFO - PROCESS | 1662 | __startTimestamp1465455676503__endTimestamp 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | ------- Summary: start ------- 00:01:16 INFO - PROCESS | 1662 | Number of tests: 6 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5235.91 Median:5421.89 stddev:587.77 (10.8%) stddev-sans-first:564.77 00:01:16 INFO - PROCESS | 1662 | Values: 3082.3 3091.9 3113.9 3133.2 3156.6 5100.0 5184.8 5201.8 5254.1 5283.2 5231.7 5239.2 5250.7 5255.6 5305.7 4711.5 4781.9 4785.6 4791.1 4984.4 4911.1 4936.5 4968.1 4971.8 4983.3 4687.0 4711.7 4766.3 4851.2 4870.3 4729.3 4742.9 4748.1 4762.0 4824.0 4758.0 4762.7 4765.9 4769.1 4780.7 5024.8 5103.6 5201.4 5206.8 5212.2 5591.4 5635.7 5646.2 5664.2 5668.1 5641.4 5647.4 5674.8 5693.7 5696.7 5144.4 5206.3 5209.5 5279.1 5283.9 5754.4 5759.6 5778.4 5837.4 5849.4 5563.9 5604.1 5606.8 5612.9 5619.2 5569.3 5681.9 5697.1 5699.1 5703.5 5464.2 5504.3 5585.2 5598.9 5634.1 5531.6 5535.9 5546.2 5549.9 5552.8 4273.0 4285.8 4288.7 4292.2 4323.6 3796.1 3827.8 3879.6 3881.0 3881.9 5355.4 5356.5 5357.7 5361.3 5392.5 5688.3 5689.5 5695.4 5722.3 5761.0 5198.1 5269.7 5297.2 5325.2 5352.8 4816.1 4850.7 4901.8 4903.5 4946.9 5553.1 5797.6 5825.2 5836.4 5859.2 5606.9 5651.8 5653.9 5686.3 5702.5 5832.7 5840.2 5858.1 5869.3 5875.3 5412.8 5510.3 5561.7 5565.9 5573.1 5616.5 5709.0 5709.8 5712.7 5767.0 5528.7 5543.3 5544.0 5544.4 5544.5 5298.6 5416.8 5469.4 5553.3 5572.0 5424.9 5435.6 5435.7 5438.9 5452.3 5520.8 5548.0 5609.1 5609.7 5610.5 5219.9 5331.7 5385.8 5394.5 5421.9 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:61730.14 Median:23603.08 stddev:119182.27 (504.9%) stddev-sans-first:119428.08 00:01:16 INFO - PROCESS | 1662 | Values: 547.2 603.6 612.5 613.8 633.4 32423.5 45303.5 46545.8 46672.8 46693.1 48225.3 48360.0 48494.3 48736.8 48781.5 8687.0 8818.2 8833.8 8844.5 8846.0 8785.7 8847.2 8857.3 8859.6 8860.4 8813.1 8900.6 8929.0 8969.1 8974.9 8829.5 8853.5 8862.9 8873.9 8877.6 8786.3 8854.3 8854.5 8859.6 8860.3 43475.1 43528.6 43718.6 43766.0 43816.0 3678.4 3721.9 3790.8 4071.6 4288.2 32950.0 33485.7 33580.8 34416.1 34800.0 3733.4 3757.7 3836.1 3870.5 3919.8 362262.0 362467.0 363231.0 363385.0 363592.0 54472.5 60197.7 60226.0 60502.7 60685.1 68101.7 70286.0 70530.6 70579.6 70605.3 16846.1 16850.9 16856.1 16871.8 16883.0 10316.0 12095.2 12205.5 12253.1 13046.6 18311.5 18824.5 19144.2 19181.3 19230.4 5712.3 5901.4 5953.3 6014.6 6067.6 911.3 1029.9 1082.7 1135.6 1193.0 33004.0 33130.0 33131.7 33245.3 33636.2 1117.8 1123.4 1161.7 1201.1 1226.3 17485.3 17531.0 17752.6 17761.2 17984.2 541100.0 543439.0 546981.0 547063.0 549012.3 60730.7 60827.4 60880.0 60915.4 61055.4 1272.8 1326.7 1352.4 1398.8 1417.2 32689.8 34031.5 34361.1 34552.5 34872.3 51885.5 52305.5 52413.7 52524.5 52526.2 421820.0 422560.0 422609.0 422679.0 422790.0 34001.5 39046.8 39273.2 43209.4 44196.0 49430.5 49451.8 49668.0 50068.7 51114.5 42217.6 42229.8 43186.6 43626.8 44060.8 41505.0 41791.7 42047.2 42654.1 42918.0 42057.0 42584.6 42991.8 43051.8 43407.0 36479.3 36963.6 37703.0 38561.6 38597.8 26626.9 28998.1 29235.4 29345.3 29407.3 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:28059.65 Median:22981.87 stddev:78934.85 (343.5%) stddev-sans-first:79128.90 00:01:16 INFO - PROCESS | 1662 | Values: 371.9 373.3 381.8 383.9 395.9 17816.8 19598.9 19860.5 20621.2 20629.9 18572.9 18746.7 18759.6 19047.8 19184.2 5460.7 5551.3 5710.5 5718.6 5729.6 5501.2 5582.6 5591.9 5632.9 5660.5 5486.4 5546.8 5580.7 5586.7 5598.8 5445.7 5569.7 5573.3 5584.6 5643.8 4851.4 4959.6 4965.1 5050.1 5054.6 22488.0 22753.8 22829.0 22974.3 22989.4 2349.2 2366.3 2382.8 2394.1 2587.6 13882.5 14235.2 14386.3 14513.9 14589.0 1907.1 1967.6 2025.9 2054.0 2061.5 77584.6 78188.6 78866.0 79500.0 81199.6 9989.6 10032.6 10354.3 10387.0 10528.7 13636.0 13711.0 13724.1 13770.7 13776.8 7924.2 8095.6 8109.9 8268.4 8295.4 7954.7 8087.2 8091.5 8109.8 8362.5 6381.3 6414.6 6430.3 6476.7 6494.5 1700.7 1795.8 1811.9 1812.2 1837.1 980.5 1007.5 1008.0 1053.9 1062.9 18536.4 19343.0 19386.3 19448.3 19841.2 1038.8 1055.5 1056.2 1071.7 1130.7 8261.7 11288.3 11317.7 11341.3 11341.8 470619.0 473739.5 478526.0 489956.0 490849.0 76316.6 78123.6 79985.0 80062.6 80512.0 1018.2 1020.4 1042.9 1050.2 1061.3 16634.0 16780.5 17124.1 17235.2 17714.9 36543.3 36628.8 36824.0 37277.3 38053.4 48233.0 50518.0 51604.0 52202.0 52490.2 8098.4 8467.5 8641.4 8678.7 8823.1 13156.1 13305.3 13328.3 13451.4 13659.2 11593.1 11691.2 11777.4 11872.3 12018.9 11278.3 11348.9 11557.9 11769.5 11861.9 11785.3 11805.9 11865.2 11969.8 12066.7 7363.9 7609.4 7689.6 8057.8 8552.3 10992.3 11708.1 11843.3 11864.8 12043.6 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5739.60 Median:432.40 stddev:3294.72 (762.0%) stddev-sans-first:3287.46 00:01:16 INFO - PROCESS | 1662 | Values: 1351.7 1504.6 1540.0 1654.8 1811.8 8351.0 8714.7 8716.7 8930.9 8933.1 8659.9 8860.6 8874.4 8881.8 8887.3 2018.5 2072.5 2075.8 2293.9 2325.3 2312.7 2390.6 2392.3 2404.1 2407.0 2252.1 2279.0 2299.9 2300.5 2302.7 2013.8 2239.2 2305.9 2344.4 2344.9 2334.5 2368.7 2370.6 2372.5 2373.7 8666.1 8743.7 8747.6 8748.2 8765.5 5083.4 5223.1 5223.7 5229.0 5230.5 3154.8 3191.6 3368.1 3381.7 3389.8 1085.0 1087.5 1097.0 1099.3 1106.2 12167.4 12332.3 12334.1 12348.0 12363.4 4594.0 4667.5 4695.8 4715.9 4738.1 10399.4 10403.5 10408.4 10411.9 10427.9 5225.7 5300.2 5303.0 5304.7 5306.8 4137.5 4694.9 4820.3 4883.5 4891.9 3899.6 3938.7 3961.6 4021.7 4051.5 1207.5 1209.6 1226.3 1230.6 1239.9 1004.6 1004.8 1016.5 1018.6 1020.4 5785.4 5904.4 5987.2 6153.3 6156.9 427.4 431.5 433.3 436.5 438.1 4049.2 4097.4 4098.0 4105.0 4124.4 10446.0 10609.6 10719.9 10815.9 10823.3 10441.7 10620.5 10640.7 10694.5 10756.8 8209.1 8247.8 8273.0 8282.4 8297.4 5890.1 5906.4 5923.0 5976.3 6005.3 9758.4 10087.1 10181.8 10188.4 10192.6 9912.0 10099.6 10121.2 10125.6 10253.1 7118.0 7339.5 7521.4 7871.3 7938.8 8342.8 8427.2 8428.2 8429.0 8455.1 7409.5 7569.8 7613.9 7617.5 7657.5 7322.0 7511.8 7528.8 7639.9 7665.4 6689.4 6722.8 6757.6 6759.4 6760.6 4836.4 5021.3 5118.6 5150.4 5172.7 4624.1 5067.4 5115.9 5187.2 5191.3 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4631.79 Median:5273.37 stddev:1360.67 (25.8%) stddev-sans-first:1325.45 00:01:16 INFO - PROCESS | 1662 | Values: 320.3 321.3 327.3 329.3 330.0 5248.2 5248.2 5261.4 5265.6 5273.9 5221.6 5248.7 5248.9 5256.1 5264.2 3851.5 3934.3 4073.5 4092.0 4105.9 4109.0 4116.8 4117.8 4124.7 4153.6 4048.9 4098.2 4099.8 4109.7 4126.2 4037.0 4112.4 4130.9 4136.3 4136.9 3628.7 3660.0 3663.0 3668.8 3681.8 5066.8 5126.3 5132.9 5133.0 5151.1 4606.7 4712.7 4728.2 4735.6 4754.5 5417.2 5449.8 5497.5 5516.9 5530.6 3972.1 3978.1 4013.4 4017.4 4026.9 5558.0 5648.0 5667.2 5774.7 5789.6 4043.7 4059.6 4066.6 4071.4 4073.9 4104.5 4110.5 4129.3 4132.9 4135.4 4388.3 4662.2 4683.0 4692.8 4732.4 5440.2 5504.0 5530.5 5567.0 5581.6 1371.2 1383.3 1389.2 1399.0 1401.3 895.1 903.0 903.1 906.5 936.6 5195.3 5226.5 5254.8 5274.7 5303.2 5526.3 5561.7 5566.5 5571.2 5572.0 5153.3 5272.7 5273.4 5273.4 5287.6 2930.3 2938.7 2947.3 2952.5 2964.8 5664.3 5678.9 5696.8 5699.3 5707.8 5384.6 5610.0 5697.9 5730.6 5732.6 5665.4 5674.5 5689.5 5718.5 5758.5 5292.9 5579.4 5595.9 5609.1 5650.0 5611.9 5646.2 5650.6 5663.0 5673.9 5825.1 5827.5 5833.4 5844.9 5866.5 3929.0 3961.6 4006.7 4015.1 4039.0 5547.5 5744.0 5763.3 5791.9 5814.0 5650.2 5655.3 5670.9 5683.9 5688.4 5282.3 5519.0 5524.5 5538.2 5541.2 5190.9 5383.7 5421.8 5439.0 5452.2 5355.5 5517.7 5517.8 5533.4 5595.8 5433.3 5437.8 5443.2 5455.3 5466.9 00:01:16 INFO - PROCESS | 1662 | 00:01:16 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:19942.54 Median:4640.79 stddev:27865.37 (600.4%) stddev-sans-first:27906.42 00:01:16 INFO - PROCESS | 1662 | Values: 786.7 793.0 810.2 829.1 838.2 14430.9 15433.5 15747.8 16223.8 16269.5 13452.9 13471.5 13604.7 13607.4 13625.9 698.8 814.2 823.1 837.0 840.5 833.8 834.3 836.6 837.7 837.9 863.2 869.6 869.7 870.4 871.2 724.5 740.7 845.2 866.9 869.4 636.3 636.4 636.5 636.6 636.7 14126.5 14126.8 14139.3 14141.6 14158.1 14201.9 14478.3 14521.4 14568.3 14574.6 12110.3 12348.8 12399.9 12506.1 12513.7 4391.6 4478.7 4533.0 4642.9 4644.7 71568.3 72204.0 72563.6 72689.0 72703.3 10362.7 10506.9 10537.0 10735.2 10970.6 20909.1 21292.3 21303.9 21329.4 21679.9 8354.2 8358.7 8509.4 8516.3 8669.8 4431.9 4596.6 4638.7 4681.3 4822.0 3531.7 3698.9 3702.5 3704.2 3707.1 590.0 593.1 600.8 602.2 602.8 686.2 688.5 692.8 697.6 705.4 9254.0 9470.6 9667.2 9690.6 9776.3 584.3 617.2 624.8 626.6 635.7 4501.9 4540.2 4567.7 4621.0 4659.7 69251.3 86794.6 106493.5 109723.5 112639.0 96191.0 96890.5 98041.0 98948.5 99043.0 82432.0 82512.6 82806.0 85050.0 85459.1 8702.8 8814.8 8848.9 8888.0 8897.2 43004.8 43376.6 45783.5 52000.7 53514.7 71202.3 71365.0 72168.3 72416.6 72819.3 12564.6 12584.3 12793.0 12844.4 13154.0 14481.9 15143.2 15178.8 15526.8 15733.1 14148.5 14227.8 14536.7 14577.6 15103.8 14198.0 14382.3 14545.3 14597.3 14631.9 13777.4 13783.3 13874.2 14093.4 14189.5 11073.3 11482.9 11915.8 12041.8 12095.8 11351.6 11703.0 11865.5 12247.0 12257.0 00:01:16 INFO - PROCESS | 1662 | -------- Summary: end -------- 00:01:16 INFO - PROCESS | 1662 | 00:01:17 INFO - TEST-INFO | 1662: exit 0 00:01:17 INFO - TEST-OK | dromaeo_css | took 1113981ms 00:01:17 INFO - TEST-START | kraken 00:01:17 INFO - operating with platform_type : linux_ 00:01:17 INFO - Initialising browser for kraken test... 00:01:17 INFO - TEST-INFO | started process 1837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVqM1VV/profile http://localhost:55931/getInfo.html) 00:01:21 INFO - PROCESS | 1837 | __metrics Screen width/height:1600/1200 00:01:21 INFO - PROCESS | 1837 | colorDepth:24 00:01:21 INFO - PROCESS | 1837 | Browser inner width/height: 1024/697 00:01:21 INFO - PROCESS | 1837 | __metrics 00:01:22 ERROR - PROCESS | 1837 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:01:22 INFO - PROCESS | 1837 | console.error: PushService: 00:01:22 INFO - PROCESS | 1837 | stateChangeProcessEnqueue: Error transitioning state 00:01:22 INFO - PROCESS | 1837 | UnknownError 00:01:23 INFO - TEST-INFO | 1837: exit 0 00:01:23 INFO - Browser initialized. 00:01:23 INFO - Running cycle 1/1 for kraken test... 00:01:23 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVqM1VV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:01:35 INFO - PROCESS | 1919 | RSS: Main: 156983296 00:01:35 INFO - PROCESS | 1919 | 00:01:38 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-beat-detection) 00:01:38 INFO - PROCESS | 1919 | RSS: Main: 214654976 00:01:38 INFO - PROCESS | 1919 | 00:01:41 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-dft) 00:01:42 INFO - PROCESS | 1919 | RSS: Main: 201469952 00:01:42 INFO - PROCESS | 1919 | 00:01:45 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-fft) 00:01:46 INFO - PROCESS | 1919 | RSS: Main: 268513280 00:01:46 INFO - PROCESS | 1919 | 00:01:48 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55931/tests/kraken/driver.html?testName=audio-oscillator) 00:01:48 INFO - PROCESS | 1919 | RSS: Main: 179101696 00:01:48 INFO - PROCESS | 1919 | 00:01:50 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:01:51 INFO - PROCESS | 1919 | RSS: Main: 184193024 00:01:51 INFO - PROCESS | 1919 | 00:01:54 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55931/tests/kraken/driver.html?testName=imaging-darkroom) 00:01:55 INFO - PROCESS | 1919 | RSS: Main: 219955200 00:01:55 INFO - PROCESS | 1919 | 00:01:58 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55931/tests/kraken/driver.html?testName=imaging-desaturate) 00:01:59 INFO - PROCESS | 1919 | RSS: Main: 220475392 00:01:59 INFO - PROCESS | 1919 | 00:02:01 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55931/tests/kraken/driver.html?testName=json-parse-financial) 00:02:02 INFO - PROCESS | 1919 | RSS: Main: 220291072 00:02:02 INFO - PROCESS | 1919 | 00:02:04 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:02:04 INFO - PROCESS | 1919 | RSS: Main: 207056896 00:02:04 INFO - PROCESS | 1919 | 00:02:06 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:02:07 INFO - PROCESS | 1919 | RSS: Main: 209981440 00:02:07 INFO - PROCESS | 1919 | 00:02:09 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:02:09 INFO - PROCESS | 1919 | RSS: Main: 215756800 00:02:09 INFO - PROCESS | 1919 | 00:02:12 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:02:12 INFO - PROCESS | 1919 | RSS: Main: 223293440 00:02:12 INFO - PROCESS | 1919 | 00:02:15 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:02:16 INFO - PROCESS | 1919 | RSS: Main: 224505856 00:02:16 INFO - PROCESS | 1919 | 00:02:17 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:55931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55931/tests/kraken/driver.html?testName=ai-astar) 00:02:18 INFO - PROCESS | 1919 | RSS: Main: 267476992 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | __start_tp_report 00:02:18 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 00:02:18 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 00:02:18 INFO - PROCESS | 1919 | |i|pagename|runs| 00:02:18 INFO - PROCESS | 1919 | |0;ai-astar;111;105;111;110;111;112;111;109;113;111 00:02:18 INFO - PROCESS | 1919 | |1;audio-beat-detection;154;125;134;174;127;130;161;126;185;133 00:02:18 INFO - PROCESS | 1919 | |2;audio-dft;160;161;161;160;161;163;162;160;160;160 00:02:18 INFO - PROCESS | 1919 | |3;audio-fft;74;73;75;131;75;74;74;74;103;73 00:02:18 INFO - PROCESS | 1919 | |4;audio-oscillator;85;85;109;86;85;86;129;85;85;128 00:02:18 INFO - PROCESS | 1919 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;117;116 00:02:18 INFO - PROCESS | 1919 | |6;imaging-darkroom;145;147;145;146;146;147;146;145;146;146 00:02:18 INFO - PROCESS | 1919 | |7;imaging-desaturate;95;94;95;95;96;95;94;95;95;95 00:02:18 INFO - PROCESS | 1919 | |8;json-parse-financial;57;58;56;58;55;59;56;56;55;56 00:02:18 INFO - PROCESS | 1919 | |9;json-stringify-tinderbox;61;62;60;60;61;61;62;61;62;62 00:02:18 INFO - PROCESS | 1919 | |10;stanford-crypto-aes;80;79;79;79;85;82;85;86;124;85 00:02:18 INFO - PROCESS | 1919 | |11;stanford-crypto-ccm;122;121;121;128;120;131;126;121;144;128 00:02:18 INFO - PROCESS | 1919 | |12;stanford-crypto-pbkdf2;161;161;160;164;160;159;158;159;159;162 00:02:18 INFO - PROCESS | 1919 | |13;stanford-crypto-sha256-iterative;64;63;65;65;63;63;63;62;61;61 00:02:18 INFO - PROCESS | 1919 | __end_tp_report 00:02:18 INFO - PROCESS | 1919 | __start_cc_report 00:02:18 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,1638 00:02:18 INFO - PROCESS | 1919 | __end_cc_report 00:02:18 INFO - PROCESS | 1919 | __startTimestamp1465455738206__endTimestamp 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | ------- Summary: start ------- 00:02:18 INFO - PROCESS | 1919 | Number of tests: 14 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:2.17 (2.0%) stddev-sans-first:2.29 00:02:18 INFO - PROCESS | 1919 | Values: 111.0 105.0 111.0 110.0 111.0 112.0 111.0 109.0 113.0 111.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:144.00 stddev:21.99 (15.3%) stddev-sans-first:23.08 00:02:18 INFO - PROCESS | 1919 | Values: 154.0 125.0 134.0 174.0 127.0 130.0 161.0 126.0 185.0 133.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 00:02:18 INFO - PROCESS | 1919 | Values: 160.0 161.0 161.0 160.0 161.0 163.0 162.0 160.0 160.0 160.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:19.31 (26.1%) stddev-sans-first:20.22 00:02:18 INFO - PROCESS | 1919 | Values: 74.0 73.0 75.0 131.0 75.0 74.0 74.0 74.0 103.0 73.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:85.00 stddev:18.52 (21.8%) stddev-sans-first:19.18 00:02:18 INFO - PROCESS | 1919 | Values: 85.0 85.0 109.0 86.0 85.0 86.0 129.0 85.0 85.0 128.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:02:18 INFO - PROCESS | 1919 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 00:02:18 INFO - PROCESS | 1919 | Values: 145.0 147.0 145.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 00:02:18 INFO - PROCESS | 1919 | Values: 95.0 94.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 95.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:1.35 (2.4%) stddev-sans-first:1.42 00:02:18 INFO - PROCESS | 1919 | Values: 57.0 58.0 56.0 58.0 55.0 59.0 56.0 56.0 55.0 56.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 00:02:18 INFO - PROCESS | 1919 | Values: 61.0 62.0 60.0 60.0 61.0 61.0 62.0 61.0 62.0 62.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:83.50 stddev:13.52 (16.2%) stddev-sans-first:14.14 00:02:18 INFO - PROCESS | 1919 | Values: 80.0 79.0 79.0 79.0 85.0 82.0 85.0 86.0 124.0 85.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.00 stddev:7.33 (5.8%) stddev-sans-first:7.62 00:02:18 INFO - PROCESS | 1919 | Values: 122.0 121.0 121.0 128.0 120.0 131.0 126.0 121.0 144.0 128.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.30 Median:160.50 stddev:1.77 (1.1%) stddev-sans-first:1.86 00:02:18 INFO - PROCESS | 1919 | Values: 161.0 161.0 160.0 164.0 160.0 159.0 158.0 159.0 159.0 162.0 00:02:18 INFO - PROCESS | 1919 | 00:02:18 INFO - PROCESS | 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.41 (2.2%) stddev-sans-first:1.45 00:02:18 INFO - PROCESS | 1919 | Values: 64.0 63.0 65.0 65.0 63.0 63.0 63.0 62.0 61.0 61.0 00:02:18 INFO - PROCESS | 1919 | -------- Summary: end -------- 00:02:18 INFO - PROCESS | 1919 | 00:02:19 INFO - TEST-INFO | 1919: exit 0 00:02:19 INFO - TEST-OK | kraken | took 62137ms 00:02:19 INFO - SUITE-END | took 1176s 00:02:19 INFO - Completed test suite (00:19:36) 00:02:19 INFO - javascript benchmark 00:02:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.306481041766, 3091.8608662610195, 3113.922151946201, 3133.169710026842, 3156.636986746525, 5099.974500127503, 5184.792608295673, 5201.7919283228675, 5254.106801843686, 5283.2075188721665, 5231.686098834072, 5239.240310155025, 5250.684958902469, 5255.579553635709, 5305.681659100456, 4711.528847115295, 4781.856544303659, 4785.641076919228, 4791.113643975876, 4984.352034235562, 4911.115999120157, 4936.531029552187, 4968.105740966625, 4971.825986090487, 4983.327250821129, 4687.039156972813, 4711.693739906895, 4766.332713420124, 4851.223804191348, 4870.342503761982, 4729.337892695025, 4742.881427964294, 4748.07412554552, 4762.0, 4823.975880120612, 4757.976210118962, 4762.690425122356, 4765.880852978668, 4769.1177132230305, 4780.665353425262, 5024.773885175139, 5103.642745007851, 5201.375834899798, 5206.7917283308625, 5212.166053431471, 5591.384947655754, 5635.718214089279, 5646.237757902672, 5664.150377443375, 5668.121441176624, 5641.407652196502, 5647.350554686182, 5674.829755107354, 5693.743781529841, 5696.743646535916, 5144.43411224765, 5206.323177986837, 5209.531142197183, 5279.102552565996, 5283.894322113575, 5754.395788442237, 5759.596828222068, 5778.36437991829, 5837.445442682938, 5849.356570777211, 5563.944360556424, 5604.131359639263, 5606.775728970877, 5612.85967850807, 5619.185218143346, 5569.303837020372, 5681.9431805681415, 5697.116946873241, 5699.059655156935, 5703.515201207943, 5464.23500709901, 5504.339479262434, 5585.162225666101, 5598.888022239533, 5634.126710359901, 5531.612787104945, 5535.861603459865, 5546.195801608825, 5549.916751248654, 5552.750126244328, 4273.0, 4285.828566857291, 4288.656907447396, 4292.227399068198, 4323.610875021201, 3796.126890815128, 3827.827747751358, 3879.553851307136, 3881.029742564359, 3881.86413475527, 5355.410904800468, 5356.491133342404, 5357.732113394315, 5361.329833770778, 5392.460753924576, 5688.345840228344, 5689.459501347365, 5695.430456954271, 5722.284714410699, 5760.971195143998, 5198.116320225571, 5269.736513174403, 5297.231901374356, 5325.201219817059, 5352.839414817562, 4816.133096042746, 4850.660453768273, 4901.779419926112, 4903.53416425439, 4946.851594452172, 5553.08374118266, 5797.594168408255, 5825.155352473952, 5836.387179346192, 5859.150423188614, 5606.887862242814, 5651.802186923438, 5653.915191272052, 5686.2607860977805, 5702.51528620072, 5832.708364581669, 5840.240768700041, 5858.091995740667, 5869.266341707286, 5875.294964604275, 5412.810551630674, 5510.338759348904, 5561.721913904208, 5565.944340556543, 5573.136163894603, 5616.522595579421, 5709.029464990878, 5709.8287051388525, 5712.742926568398, 5767.048437007847, 5528.668279903219, 5543.251661025871, 5544.0, 5544.390117087198, 5544.473275038865, 5298.6290959634, 5416.7562459688625, 5469.425710300361, 5553.333599968029, 5571.9721401392735, 5424.891502170013, 5435.646682965595, 5435.673859568438, 5438.945610543844, 5452.291202143696, 5520.751566179451, 5548.029094908295, 5609.074502707171, 5609.719514024364, 5610.5231055360755, 5219.947800521946, 5331.733413329395, 5385.8114965976, 5394.541463975449, 5421.888512854776], "value": 5197.104266053133, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.2229434203431, 603.592575011867, 612.4793925163611, 613.8005148326793, 633.4045996763045, 32423.51364729528, 45303.546964530346, 46545.767271163684, 46672.76663616677, 46693.06613867725, 48225.27662085072, 48360.0, 48494.27258591124, 48736.75631621837, 48781.51218487814, 8686.999999999984, 8818.20636142747, 8833.779155521099, 8844.469331840079, 8846.02693703692, 8785.692500762474, 8847.247983921343, 8857.335699822506, 8859.601317940707, 8860.424072435271, 8813.074627164151, 8900.554972251393, 8928.973168085688, 8969.103089691043, 8974.910250897472, 8829.514376709278, 8853.513056781874, 8862.86705699415, 8873.866891996626, 8877.644894204224, 8786.253168480687, 8854.29165666745, 8854.468731876044, 8859.601317940707, 8860.291176705912, 43475.13049739019, 43528.56471435277, 43718.56281437177, 43766.0, 43816.0, 3678.411454167347, 3721.9441708374397, 3790.7915064671433, 4071.5928407159345, 4288.16380805743, 32950.0, 33485.665143348495, 33580.83209583961, 34416.13959651004, 34800.0, 3733.4213196954515, 3757.6618104370737, 3836.079340958178, 3870.4968354114067, 3919.7648141111627, 362262.0, 362467.0, 363231.0, 363385.0, 363592.0, 54472.45527544753, 60197.69901150554, 60226.0, 60502.69748651316, 60685.08972365418, 68101.65949170322, 70286.0, 70530.64734676294, 70579.64710176416, 70605.2939470609, 16846.07346595949, 16850.915745421193, 16856.07291598974, 16871.831281687028, 16883.0, 10316.0, 12095.213811102427, 12205.511779528897, 12253.081018923616, 13046.608601741962, 18311.450656480327, 18824.529386765167, 19144.234230630896, 19181.273685368385, 19230.423087307405, 5712.257761382735, 5901.380355062656, 5953.315368732565, 6014.609050411709, 6067.575269731076, 911.2664305234217, 1029.8712660917386, 1082.6643740440488, 1135.5968631135993, 1193.0, 33004.0, 33130.0, 33131.66868331334, 33245.335093297996, 33636.1590960228, 1117.8043842327722, 1123.4496394974883, 1161.703765539782, 1201.1111777284746, 1226.2948804437485, 17485.30058797659, 17531.032979661326, 17752.644947100987, 17761.200745966464, 17984.190711418018, 541100.0, 543439.0, 546981.0, 547063.0, 549012.3339516186, 60730.69634651799, 60827.39172608306, 60880.0, 60915.39084609186, 61055.38944610586, 1272.7963525836008, 1326.7014921642553, 1352.3508715816267, 1398.8391334996402, 1417.2417756500222, 32689.836550818047, 34031.476273114386, 34361.140971475914, 34552.48171277383, 34872.30255394929, 51885.48114518807, 52305.47694523006, 52413.7379313101, 52524.474755251955, 52526.21210681919, 421820.0, 422560.0, 422609.0, 422679.0, 422790.0, 34001.48997765085, 39046.80476597599, 39273.214535709696, 43209.35185972276, 44196.0, 49430.50569494259, 49451.752741236065, 49668.0, 50068.742782007364, 51114.488855110976, 42217.57782422259, 42229.78885105555, 43186.56813431825, 43626.78186609047, 44060.779696101315, 41505.0, 41791.746247612624, 42047.15905681808, 42654.146917062106, 42918.0, 42057.0, 42584.57415425806, 42991.785041074596, 43051.784741076095, 43407.0, 36479.27041459103, 36963.63036369709, 37703.0, 38561.614383856926, 38597.80701096477, 26626.866865665546, 28998.11512251697, 29235.415291694473, 29345.266368340963, 29407.26481837971], "value": 20654.431464541558, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.92561487702466, 373.3298728781836, 381.8129116732801, 383.94048922417034, 395.86144849302747, 17816.82183178168, 19598.90200548999, 19860.50348741282, 20621.17515299388, 20629.896850515765, 18572.907135464302, 18746.71879921799, 18759.591679125508, 19047.809521904775, 19184.23263069479, 5460.726963651811, 5551.250581171531, 5710.457506536873, 5718.628289161212, 5729.627574207684, 5501.202325662796, 5582.637128586629, 5591.860203494904, 5632.915506267389, 5660.462256085686, 5486.3690675572225, 5546.750396232179, 5580.665160090387, 5586.720663966806, 5598.832035038935, 5445.673259604397, 5569.693666848321, 5573.27547418837, 5584.581156413265, 5643.802466913679, 4851.369321988154, 4959.578435832958, 4965.131102057126, 5050.141475949097, 5054.620903432257, 22488.0, 22753.77246227533, 22829.0, 22974.310770676908, 22989.425264368358, 2349.2130136404326, 2366.337425520857, 2382.833201675883, 2394.0663141374703, 2587.637730717701, 13882.514112006133, 14235.217063061527, 14386.280685965765, 14513.854861451357, 14589.0, 1907.12272354717, 1967.6359873423462, 2025.8581899267058, 2053.9897300513403, 2061.494933741243, 77584.61207693926, 78188.60905695493, 78866.0, 79499.99999999942, 81199.59400203021, 9989.550470228856, 10032.64885728996, 10354.275200736027, 10387.0, 10528.684139475828, 13636.0, 13711.040227184201, 13724.107932984523, 13770.724585508233, 13776.793348099787, 7924.247196516321, 8095.55474448911, 8109.918900811034, 8268.421210515206, 8295.419320647617, 7954.721584744506, 8087.1912808719835, 8091.514509129471, 8109.797255068553, 8362.498250105013, 6381.266154392304, 6414.61512309263, 6430.260520040161, 6476.676166191672, 6494.480441564663, 1700.6768713944311, 1795.8293962073583, 1811.900345480985, 1812.238859678938, 1837.0814592703648, 980.519545422752, 1007.4559737741538, 1007.9949600251952, 1053.8840727519967, 1062.940935091387, 18536.351227706964, 19343.0, 19386.321478748177, 19448.319308824124, 19841.206351746056, 1038.8078205532001, 1055.4986381468893, 1056.1603525197486, 1071.6838532632892, 1130.7286251299793, 8261.669533218605, 11288.322700637824, 11317.71705707364, 11341.319520828776, 11341.829872551918, 470619.0, 473739.4695397859, 478526.0, 489956.0, 490849.0, 76316.61841690868, 78123.60938195273, 79985.0, 80062.59968700235, 80512.0, 1018.1854516386861, 1020.4489575629077, 1042.9322094063862, 1050.2280823594651, 1061.2518174686827, 16634.0, 16780.496585102468, 17124.14379281056, 17235.22441490111, 17714.91142544279, 36543.26913461769, 36628.816855916615, 36824.0, 37277.25445491021, 38053.42919856149, 48233.0, 50518.0, 51604.0, 52202.0, 52490.212646811095, 8098.3926205536, 8467.53428561435, 8641.351898607503, 8678.696245631372, 8823.117688231383, 13156.144850584682, 13305.268210248529, 13328.33358332099, 13451.394687238902, 13659.180449173082, 11593.130515211224, 11691.181617286707, 11777.35224562623, 11872.287662740264, 12018.939905300418, 11278.266912650652, 11348.943255283672, 11557.942210288895, 11769.52921883115, 11861.881381186078, 11785.292882427082, 11805.940970295094, 11865.228760130563, 11969.760604787682, 12066.698332541757, 7363.926360736324, 7609.391248700202, 7689.577073261024, 8057.798555036171, 8552.315814734682, 10992.28550144238, 11708.063354931415, 11843.348615826213, 11864.762704745684, 12043.578474753342], "value": 9178.06851206428, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.6553278913875, 1504.6012806606248, 1540.0143907898944, 1654.8179700232972, 1811.7644706188194, 8350.958245208772, 8714.651413943442, 8716.694915677945, 8930.866037009433, 8933.062028487013, 8659.91340086599, 8860.645574177026, 8874.378793484459, 8881.822363552725, 8887.28901687865, 2018.495376155961, 2072.450800537859, 2075.782042885498, 2293.8738369389716, 2325.3140323604575, 2312.6646636237733, 2390.6294524348755, 2392.3301475586863, 2404.0984630763464, 2406.9638955415685, 2252.054137262354, 2279.0200213908015, 2299.9195028174017, 2300.459392042869, 2302.7236731592147, 2013.8489613278916, 2239.2050821958296, 2305.9308220753405, 2344.4490544721975, 2344.9179278725246, 2334.4514039200776, 2368.715754109518, 2370.608849539824, 2372.5373552157334, 2373.6795532603223, 8666.090060543678, 8743.650253989832, 8747.606357713918, 8748.212660860552, 8765.474071555727, 5083.364579427572, 5223.059849227137, 5223.660462069954, 5229.0, 5230.529252367305, 3154.794938329001, 3191.6329622093526, 3368.073779710575, 3381.746369022333, 3389.813565252142, 1084.967450976472, 1087.472575800736, 1097.040089921319, 1099.2964502718266, 1106.1758989552834, 12167.391630418444, 12332.260064396165, 12334.074944379208, 12348.0, 12363.443645036084, 4593.954060459353, 4667.486576476585, 4695.7886895089805, 4715.858524244278, 4738.099761045391, 10399.376037437778, 10403.53184106717, 10408.427536485566, 10411.94794026025, 10427.895721042843, 5225.6603320784025, 5300.1519756838725, 5302.973485132549, 5304.655197412233, 5306.8407947761625, 4137.50349958001, 4694.859154225379, 4820.30105634681, 4883.4628190898975, 4891.926621100686, 3899.5515515715488, 3938.680542018456, 3961.643452089326, 4021.6983726220064, 4051.453053837753, 1207.4868181023205, 1209.5766481731323, 1226.2826246645811, 1230.6000549821345, 1239.9380030998595, 1004.5780772075746, 1004.8392257238806, 1016.537475448669, 1018.6434747838346, 1020.4438580973388, 5785.363610002896, 5904.380040095814, 5987.221661184019, 6153.323134455206, 6156.8768624627255, 427.4293817753272, 431.5016156339433, 433.3002201444707, 436.46968932746864, 438.1150076844756, 4049.190161967618, 4097.405876147942, 4097.97951010243, 4104.958950410517, 4124.381342798604, 10446.0, 10609.628662996758, 10719.946400267949, 10815.945920270347, 10823.296485728402, 10441.68674939753, 10620.522076506575, 10640.733981650521, 10694.465276736131, 10756.78486430267, 8209.09699933007, 8247.793805154919, 8273.0, 8282.378821588405, 8297.419180657296, 5890.14592884038, 5906.438888305604, 5923.0, 5976.342602313829, 6005.309389420097, 9758.414495130315, 10087.142592879394, 10181.796364072825, 10188.439635819805, 10192.592296308065, 9912.0, 10099.596016159565, 10121.240906932157, 10125.59497620087, 10253.128484078938, 7118.0, 7339.486235963432, 7521.360684341674, 7871.291583757489, 7938.801529961797, 8342.83314333722, 8427.157284271523, 8428.157184281523, 8429.030661473764, 8455.11221321777, 7409.518381305414, 7569.772906812805, 7613.885791713018, 7617.5048621839405, 7657.502262352929, 7322.0, 7511.812204694927, 7528.774136775905, 7639.923600763921, 7665.386769058574, 6689.431398331002, 6722.764703235559, 6757.628330441873, 6759.357861003196, 6760.628165450751, 4836.371271734652, 5021.3472248608905, 5118.616103792305, 5150.356205474316, 5172.689638621695, 4624.1445332613575, 5067.366579177603, 5115.948840511696, 5187.19598462239, 5191.273221748883], "value": 4505.855515154203, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.3033402349889, 321.33644025088194, 327.3191761136835, 329.25588170734136, 329.98020118792874, 5248.186531087683, 5248.212768084789, 5261.3949395819445, 5265.631405801595, 5273.920891186631, 5221.624161006743, 5248.71132087735, 5248.897731476385, 5256.106461901476, 5264.157734762429, 3851.5185601799776, 3934.291827471047, 4073.490813648294, 4092.0358228050404, 4105.897352566195, 4108.958910410887, 4116.75299482032, 4117.752934823905, 4124.690648201382, 4153.563875793044, 4048.898777530556, 4098.159877225176, 4099.7745124018165, 4109.732867363627, 4126.195391898581, 4037.0311125330004, 4112.3625837995005, 4130.855420060314, 4136.31750761124, 4136.945079004865, 3628.673419392241, 3659.9634003660153, 3662.981685091584, 3668.779873207616, 3681.7606855554304, 5066.847994560169, 5126.333576635051, 5132.948670513321, 5133.048497114174, 5151.094095184768, 4606.746628935407, 4712.717236965793, 4728.172569800306, 4735.57379835813, 4754.477007529169, 5417.160340147283, 5449.782008719647, 5497.532709719679, 5516.8966206758805, 5530.557555395559, 3972.106276087886, 3978.124812541236, 4013.4180543821276, 4017.397390391465, 4026.939595906064, 5558.0269004503625, 5647.971760141214, 5667.234923285386, 5774.740136693817, 5789.594728369016, 4043.6562892154498, 4059.594040595976, 4066.6340029397497, 4071.4096456014304, 4073.918521629551, 4104.548499665035, 4110.547839737626, 4129.29801933672, 4132.896677583084, 4135.359019352005, 4388.29787234041, 4662.230731929261, 4682.953170468251, 4692.7653617319, 4732.361131247307, 5440.231924624433, 5503.972480137573, 5530.5022547970875, 5567.0, 5581.576697941999, 1371.163590209971, 1383.3359987206197, 1389.215093472185, 1398.9927252378272, 1401.2923473645744, 895.1183084661603, 902.9593668284942, 903.074348792493, 906.5240748607034, 936.5738588942015, 5195.2986346843445, 5226.529612334832, 5254.789808407697, 5274.736263186825, 5303.178007408857, 5526.281583394133, 5561.721913904288, 5566.526845218121, 5571.220029195916, 5571.9721401392735, 5153.330067091254, 5272.657277276965, 5273.367195936436, 5273.367195936512, 5287.576993840484, 2930.2527855397166, 2938.691437399085, 2947.2779169103705, 2952.512835382181, 2964.8072875263038, 5664.320281566238, 5678.858028549319, 5696.772129114789, 5699.31870098322, 5707.771689132472, 5384.596155288291, 5610.0, 5697.886042279214, 5730.627509211888, 5732.570057245724, 5665.433456654384, 5674.517665998354, 5689.516391106802, 5718.542516598662, 5758.510526605285, 5292.914952434665, 5579.386267510652, 5595.916061259003, 5609.13933893709, 5650.0, 5611.8877622448135, 5646.237757902631, 5650.57620678459, 5662.971685141548, 5673.886522269614, 5825.126231065374, 5827.475527202572, 5833.445822646841, 5844.883102338014, 5866.472017518444, 3929.0499648836453, 3961.643452089326, 4006.719529633014, 4015.096603264359, 4039.0, 5547.472990065938, 5744.0, 5763.33721622002, 5791.8552036199435, 5814.0, 5650.180723794944, 5655.349634792052, 5670.914936275876, 5683.857903552444, 5688.40271771458, 5282.260483532232, 5518.951399234133, 5524.502794748492, 5538.196961440488, 5541.224228608079, 5190.870228244324, 5383.7308134593895, 5421.810236641699, 5438.972805135949, 5452.236686863922, 5355.500459871242, 5517.7033397150835, 5517.806876759294, 5533.391326953952, 5595.776168953359, 5433.347998240237, 5437.755301011385, 5443.210734443563, 5455.345358556999, 5466.8906621866545], "value": 4193.609328440891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.7246463737692, 792.9841403171937, 810.1817164663692, 829.108708138751, 838.1576515601821, 14430.927845360771, 15433.45982890599, 15747.842521574781, 16223.75664365034, 16269.51191464255, 13452.865471345283, 13471.461141554326, 13604.659883502918, 13607.387667554958, 13625.863741362584, 698.8183072401162, 814.1898810683379, 823.1028179284564, 836.9665213391457, 840.4579046514995, 833.7998880268752, 834.2616784146044, 836.5524444422235, 837.7319257837495, 837.9162083791633, 863.1541089732067, 869.5739087846941, 869.74342568942, 870.4168207301092, 871.2072014466836, 724.4747558020446, 740.6815069520131, 845.2055068235838, 866.9133086691312, 869.4131461263622, 636.2555809702659, 636.4081404294004, 636.535329209675, 636.5830381100386, 636.723025483916, 14126.505572305023, 14126.788098178535, 14139.293035348293, 14141.575752727435, 14158.079724817853, 14201.928990354982, 14478.348474318682, 14521.419143234258, 14568.271586420742, 14574.562763117123, 12110.320107532252, 12348.814767778491, 12399.876001239962, 12506.124571279923, 12513.687157821036, 4391.6267117295065, 4478.708883922567, 4532.9546704533195, 4642.930356044662, 4644.651651126179, 71568.2843171572, 72203.99999999948, 72563.63718181428, 72689.0, 72703.27296727018, 10362.689119326433, 10506.894931050592, 10537.0, 10735.194860385345, 10970.616028439126, 20909.108918736925, 21292.25477108294, 21303.893480532497, 21329.360119196448, 21679.891600541898, 8354.206350396702, 8358.665653373919, 8509.446885952393, 8516.318694504425, 8669.826603467895, 4431.911361772746, 4596.609288210473, 4638.652101092432, 4681.274402467623, 4821.951780482221, 3531.6644918732677, 3698.8705395311035, 3702.500162478085, 3704.1665625234104, 3707.1102935295876, 590.0470739755265, 593.1073734030257, 600.7506884642912, 602.2411761180856, 602.7739597650881, 686.1800148822209, 688.5283580747205, 692.8246002362346, 697.6197972105215, 705.4427002667937, 9254.0, 9470.573824177929, 9667.226621870233, 9690.56392462341, 9776.315657903879, 584.2784161560469, 617.1822335405606, 624.7750809708501, 626.5614070150913, 635.7266375458505, 4501.909961800746, 4540.205464043779, 4567.703099298601, 4620.976895115503, 4659.720416775004, 69251.30748692449, 86794.56602716947, 106493.46753266185, 109723.45138274417, 112639.0, 96191.0, 96890.5155474218, 98041.0, 98948.5052574747, 99043.0, 82432.0, 82512.58743706244, 82806.0, 85050.0, 85459.14540854511, 8702.782430439289, 8814.823703525766, 8848.91151088481, 8887.955560222157, 8897.199252067345, 43004.78497607617, 43376.56623433851, 45783.54216457793, 52000.73999629977, 53514.73242633762, 71202.28797712164, 71365.0, 72168.27831721616, 72416.6379168122, 72819.27180728124, 12564.623061308175, 12584.307863067253, 12793.040521961077, 12844.422001010164, 13154.013448991554, 14481.85518144805, 15143.199281508743, 15178.772318415453, 15526.767098493758, 15733.134677592841, 14148.504802331869, 14227.786583201054, 14536.709265814836, 14577.635559111108, 15103.848961510685, 14197.971860054276, 14382.28088595587, 14545.272736363351, 14597.270136493345, 14631.92684036573, 13777.448902043807, 13783.310834458036, 13874.167549947035, 14093.365798538885, 14189.503367382093, 11073.280236784905, 11482.852552909102, 11915.82126268124, 12041.819372709591, 12095.818562721743, 11351.602693905674, 11702.967723878473, 11865.525378984745, 12247.0, 12257.0], "value": 7489.5585462649915, "unit": "score"}], "name": "dromaeo_css", "value": 7201.106474551451, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 111.0, 110.0, 111.0, 112.0, 111.0, 109.0, 113.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 134.0, 174.0, 127.0, 130.0, 161.0, 126.0, 185.0, 133.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 160.0, 161.0, 163.0, 162.0, 160.0, 160.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 131.0, 75.0, 74.0, 74.0, 74.0, 103.0, 73.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 109.0, 86.0, 85.0, 86.0, 129.0, 85.0, 85.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 56.0, 58.0, 55.0, 59.0, 56.0, 56.0, 55.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 62.0, 62.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 79.0, 85.0, 82.0, 85.0, 86.0, 124.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 121.0, 128.0, 120.0, 131.0, 126.0, 121.0, 144.0, 128.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 164.0, 160.0, 159.0, 158.0, 159.0, 159.0, 162.0], "value": 160.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 65.0, 65.0, 63.0, 63.0, 63.0, 62.0, 61.0, 61.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1506.2, "alertThreshold": 2.0}]} 00:02:19 INFO - Return code: 0 00:02:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:02:19 ERROR - # TBPL SUCCESS # 00:02:19 INFO - Running post-action listener: _resource_record_post_action 00:02:19 INFO - ##### 00:02:19 INFO - ##### Finished run-tests step (success) 00:02:19 INFO - ##### 00:02:19 INFO - Running post-run listener: _resource_record_post_run 00:02:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551206912; Read time: 8; Write time: 1664836 00:02:19 INFO - TinderboxPrint: CPU usage
13.2% 00:02:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 00:02:19 INFO - TinderboxPrint: I/O write bytes / time
551,206,912 / 1,664,836 00:02:19 INFO - TinderboxPrint: CPU idle
8,273.8 (86.7%) 00:02:19 INFO - TinderboxPrint: CPU user
1,205.8 (12.6%) 00:02:19 INFO - TinderboxPrint: Swap in / out
0 / 0 00:02:19 INFO - install - Wall time: 18s; CPU: 20.0%; Read bytes: 0; Write bytes: 256315392; Read time: 0; Write time: 1090868 00:02:19 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294305792; Read time: 8; Write time: 573904 00:02:20 INFO - Running post-run listener: _upload_blobber_files 00:02:20 INFO - Blob upload gear active. 00:02:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:02:20 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 00:02:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:02:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:02:20 INFO - (blobuploader) - INFO - Open directory for files ... 00:02:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:02:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:02:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:25 INFO - (blobuploader) - INFO - Done attempting. 00:02:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:02:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:02:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:26 INFO - (blobuploader) - INFO - Done attempting. 00:02:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:02:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:02:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:27 INFO - (blobuploader) - INFO - Done attempting. 00:02:27 INFO - (blobuploader) - INFO - Iteration through files over. 00:02:27 INFO - Return code: 0 00:02:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:02:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:02:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b881ec8da07813727c19f9ea590b27f19cfde5f380f26a2a2f2ff88d2f63c8728cf622cefeb4dcf6d5a4735e4fafb6915d378206e3b387aef1d048e9279b7cb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8acc9658a19a7cf11e5e8bd5253224573488705d1955554b3c76c317f24b9d867f9894abf9c2875e30987f26dc98436a85c423297346ab180929313cc92e0707", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f11130fad4564664bb98d793a227c6b2724e4cbfda5dbf0b5c0d3861d4e36f06ea44b2bdf1e0cd742eea19a373d2c99d87cbc604b0f0edce4c746dee0c2a802b"} 00:02:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:02:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:02:27 INFO - Contents: 00:02:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b881ec8da07813727c19f9ea590b27f19cfde5f380f26a2a2f2ff88d2f63c8728cf622cefeb4dcf6d5a4735e4fafb6915d378206e3b387aef1d048e9279b7cb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8acc9658a19a7cf11e5e8bd5253224573488705d1955554b3c76c317f24b9d867f9894abf9c2875e30987f26dc98436a85c423297346ab180929313cc92e0707", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f11130fad4564664bb98d793a227c6b2724e4cbfda5dbf0b5c0d3861d4e36f06ea44b2bdf1e0cd742eea19a373d2c99d87cbc604b0f0edce4c746dee0c2a802b"} 00:02:27 INFO - Running post-run listener: copy_logs_to_upload_dir 00:02:27 INFO - Copying logs to upload dir... 00:02:27 INFO - mkdir: /builds/slave/test/build/upload/logs 00:02:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.426290 ========= master_lag: 278.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 38 secs) (at 2016-06-09 00:07:05.286011) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.289976) ========= 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=df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b881ec8da07813727c19f9ea590b27f19cfde5f380f26a2a2f2ff88d2f63c8728cf622cefeb4dcf6d5a4735e4fafb6915d378206e3b387aef1d048e9279b7cb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8acc9658a19a7cf11e5e8bd5253224573488705d1955554b3c76c317f24b9d867f9894abf9c2875e30987f26dc98436a85c423297346ab180929313cc92e0707", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f11130fad4564664bb98d793a227c6b2724e4cbfda5dbf0b5c0d3861d4e36f06ea44b2bdf1e0cd742eea19a373d2c99d87cbc604b0f0edce4c746dee0c2a802b"} build_url:https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b881ec8da07813727c19f9ea590b27f19cfde5f380f26a2a2f2ff88d2f63c8728cf622cefeb4dcf6d5a4735e4fafb6915d378206e3b387aef1d048e9279b7cb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8acc9658a19a7cf11e5e8bd5253224573488705d1955554b3c76c317f24b9d867f9894abf9c2875e30987f26dc98436a85c423297346ab180929313cc92e0707", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f11130fad4564664bb98d793a227c6b2724e4cbfda5dbf0b5c0d3861d4e36f06ea44b2bdf1e0cd742eea19a373d2c99d87cbc604b0f0edce4c746dee0c2a802b"}' ========= master_lag: 0.48 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.782989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.783298) ========= 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=df17445c3590ff7897617a0e00000225-1465452096.637370-1502575376 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004522 ========= master_lag: 0.10 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.885240) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-06-09 00:07:05.885560) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-06-09 00:07:07.706051) ========= ========= Total master_lag: 278.74 =========