builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1465454485.47 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.476110) ========= 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.476633) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.476941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.526963) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.527367) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468 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% 38.4M=0s 2016-06-08 23:41:25 (38.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075517 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.620187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.620559) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017916 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:25.676160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 23:41:25.676521) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-08 23:41:26,068 truncating revision to first 12 chars 2016-06-08 23:41:26,068 Setting DEBUG logging. 2016-06-08 23:41:26,068 attempt 1/10 2016-06-08 23:41:26,068 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,551 unpacking tar archive at: fx-team-8a447c89176f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.074665 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-08 23:41:26.765373) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.765714) ========= script_repo_revision: 8a447c89176fb240f78db350e8d65f62d0a6fabb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.766120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.766394) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-08 23:41:26.775825) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 38 secs) (at 2016-06-08 23:41:26.776187) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468 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-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', 23:41:27 INFO - 'system_bits': '32', 23:41:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:41:27 INFO - 'title': 'talos-linux64-ix-060', 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:27 INFO - Running post-action listener: _resource_record_post_action 23:41:27 INFO - ##### 23:41:27 INFO - ##### Finished clobber step (success) 23:41:27 INFO - ##### 23:41:27 INFO - ##### 23:41:27 INFO - ##### Running read-buildbot-config 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: read_buildbot_config 23:41:27 INFO - Using buildbot properties: 23:41:27 INFO - { 23:41:27 INFO - "project": "", 23:41:27 INFO - "product": "firefox", 23:41:27 INFO - "script_repo_revision": "production", 23:41:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:41:27 INFO - "repository": "", 23:41:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:41:27 INFO - "buildid": "20160608173003", 23:41:27 INFO - "pgo_build": "True", 23:41:27 INFO - "basedir": "/builds/slave/test", 23:41:27 INFO - "buildnumber": 443, 23:41:27 INFO - "slavename": "talos-linux64-ix-060", 23:41:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:41:27 INFO - "platform": "ubuntu64_hw", 23:41:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:41:27 INFO - "branch": "fx-team", 23:41:27 INFO - "repo_path": "integration/fx-team", 23:41:27 INFO - "revision": "8a447c89176fb240f78db350e8d65f62d0a6fabb", 23:41:27 INFO - "stage_platform": "linux64-pgo", 23:41:27 INFO - "builduid": "5409e863a65f46c7a617fd02e75a93b5", 23:41:27 INFO - "slavebuilddir": "test" 23:41:27 INFO - } 23:41:27 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:27 INFO - Running post-action listener: _resource_record_post_action 23:41:27 INFO - ##### 23:41:27 INFO - ##### Finished read-buildbot-config step (success) 23:41:27 INFO - ##### 23:41:27 INFO - ##### 23:41:27 INFO - ##### Running download-and-extract 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: download_and_extract 23:41:27 INFO - mkdir: /builds/slave/test/build/tests 23:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:27 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:27 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:27 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:27 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:27 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:38 INFO - Downloaded 1361 bytes. 23:41:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:41:38 INFO - Using the following test package requirements: 23:41:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:41:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:41:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:41:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'jsshell-linux-x86_64.zip'], 23:41:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:41:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:41:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:41:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:41:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:41:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:41:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:41:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:41:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:38 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:38 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:38 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:38 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:38 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:50 INFO - Downloaded 24451190 bytes. 23:41:50 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:50 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:51 INFO - Return code: 0 23:41:51 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:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:51 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:51 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:51 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:51 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:51 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:52 INFO - Downloaded 24451190 bytes. 23:41:52 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:52 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:54 INFO - Return code: 0 23:41:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:54 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:54 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:54 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:54 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:54 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:55 INFO - Downloaded 10833369 bytes. 23:41:55 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:55 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:55 INFO - Return code: 0 23:41:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:41:55 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:55 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:55 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:55 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:55 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:57 INFO - Downloaded 59327656 bytes. 23:41:57 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:57 INFO - mkdir: /builds/slave/test/properties 23:41:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:41:57 INFO - Writing to file /builds/slave/test/properties/build_url 23:41:57 INFO - Contents: 23:41:57 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:58 INFO - Running post-action listener: _resource_record_post_action 23:41:58 INFO - Running post-action listener: set_extra_try_arguments 23:41:58 INFO - ##### 23:41:58 INFO - ##### Finished download-and-extract step (success) 23:41:58 INFO - ##### 23:41:58 INFO - ##### 23:41:58 INFO - ##### Running populate-webroot step. 23:41:58 INFO - ##### 23:41:58 INFO - Running pre-action listener: _resource_record_pre_action 23:41:58 INFO - Running main action method: populate_webroot 23:41:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:41:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:41:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:41:58 INFO - '--tppagecycles', 23:41:58 INFO - '7'], 23:41:58 INFO - 'tests': ['tsvgm']}}, 23:41:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:41:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:41:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:41:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:41:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:41:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:41:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['damp', 'tps']}, 23:41:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'tests': ['damp', 'tps']}, 23:41:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['dromaeo_dom']}, 23:41:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:41:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['a11yr', 23:41:58 INFO - 'ts_paint', 23:41:58 INFO - 'tpaint', 23:41:58 INFO - 'sessionrestore', 23:41:58 INFO - 'sessionrestore_no_auto_restore', 23:41:58 INFO - 'tabpaint']}, 23:41:58 INFO - 'other-e10s': {'tests': ['a11yr', 23:41:58 INFO - 'ts_paint', 23:41:58 INFO - 'tpaint', 23:41:58 INFO - 'sessionrestore', 23:41:58 INFO - 'sessionrestore_no_auto_restore', 23:41:58 INFO - 'tabpaint']}, 23:41:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:41:58 INFO - 'ts_paint', 23:41:58 INFO - 'tpaint', 23:41:58 INFO - 'sessionrestore', 23:41:58 INFO - 'sessionrestore_no_auto_restore', 23:41:58 INFO - 'tabpaint']}, 23:41:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:41:58 INFO - 'ts_paint', 23:41:58 INFO - 'tpaint', 23:41:58 INFO - 'sessionrestore', 23:41:58 INFO - 'sessionrestore_no_auto_restore', 23:41:58 INFO - 'tabpaint']}, 23:41:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['a11yr', 23:41:58 INFO - 'ts_paint', 23:41:58 INFO - 'tpaint', 23:41:58 INFO - 'sessionrestore', 23:41:58 INFO - 'sessionrestore_no_auto_restore', 23:41:58 INFO - 'tabpaint']}, 23:41:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['a11yr', 23:41:58 INFO - 'ts_paint', 23:41:58 INFO - 'tpaint', 23:41:58 INFO - 'sessionrestore', 23:41:58 INFO - 'sessionrestore_no_auto_restore', 23:41:58 INFO - 'tabpaint']}, 23:41:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['tsvgx', 23:41:58 INFO - 'tsvgr_opacity', 23:41:58 INFO - 'tart', 23:41:58 INFO - 'tscrollx', 23:41:58 INFO - 'cart']}, 23:41:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:41:58 INFO - 'tsvgr_opacity', 23:41:58 INFO - 'tart', 23:41:58 INFO - 'tscrollx', 23:41:58 INFO - 'cart']}, 23:41:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'talos_options': ['--disable-e10s'], 23:41:58 INFO - 'tests': ['tp5o']}, 23:41:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'tests': ['tp5o']}, 23:41:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'talos_options': ['--disable-e10s', 23:41:58 INFO - '--xperf_path', 23:41:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:41:58 INFO - 'tests': ['tp5n']}, 23:41:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:41:58 INFO - 'talos_options': ['--xperf_path', 23:41:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:41:58 INFO - 'tests': ['tp5n']}}, 23:41:58 INFO - 'talos.zip': {'path': '', 23:41:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:41:58 INFO - Running post-action listener: _resource_record_post_action 23:41:58 INFO - ##### 23:41:58 INFO - ##### Finished populate-webroot step (success) 23:41:58 INFO - ##### 23:41:58 INFO - ##### 23:41:58 INFO - ##### Running create-virtualenv step. 23:41:58 INFO - ##### 23:41:58 INFO - Running pre-action listener: _resource_record_pre_action 23:41:58 INFO - Running main action method: create_virtualenv 23:41:58 INFO - Creating virtualenv /builds/slave/test/build/venv 23:41:58 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:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:41:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:41:58 INFO - Using real prefix '/usr' 23:41:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:41:58 INFO - Installing distribute.............................................................................................................................................................................................done. 23:42:00 INFO - Installing pip.................done. 23:42:00 INFO - Return code: 0 23:42:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:00 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 23:42:00 INFO - 'HOME': '/home/cltbld', 23:42:00 INFO - 'LANG': 'en_US.UTF-8', 23:42:00 INFO - 'LANGUAGE': 'en_US:en', 23:42:00 INFO - 'LOGNAME': 'cltbld', 23:42:00 INFO - 'MAIL': '/var/mail/cltbld', 23:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:00 INFO - 'MOZ_NO_REMOTE': '1', 23:42:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:00 INFO - 'NO_EM_RESTART': '1', 23:42:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:00 INFO - 'PWD': '/builds/slave/test', 23:42:00 INFO - 'SHELL': '/bin/bash', 23:42:00 INFO - 'SHLVL': '1', 23:42:00 INFO - 'TERM': 'linux', 23:42:00 INFO - 'TMOUT': '86400', 23:42:00 INFO - 'USER': 'cltbld', 23:42:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:00 INFO - '_': '/tools/buildbot/bin/python'} 23:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:01 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:01 INFO - Cleaning up... 23:42:01 INFO - Return code: 0 23:42:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:42:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:01 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:01 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:01 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:01 INFO - Using env: {'DISPLAY': ':0', 23:42:01 INFO - 'HOME': '/home/cltbld', 23:42:01 INFO - 'LANG': 'en_US.UTF-8', 23:42:01 INFO - 'LANGUAGE': 'en_US:en', 23:42:01 INFO - 'LOGNAME': 'cltbld', 23:42:01 INFO - 'MAIL': '/var/mail/cltbld', 23:42:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:01 INFO - 'MOZ_NO_REMOTE': '1', 23:42:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:01 INFO - 'NO_EM_RESTART': '1', 23:42:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:01 INFO - 'PWD': '/builds/slave/test', 23:42:01 INFO - 'SHELL': '/bin/bash', 23:42:01 INFO - 'SHLVL': '1', 23:42:01 INFO - 'TERM': 'linux', 23:42:01 INFO - 'TMOUT': '86400', 23:42:01 INFO - 'USER': 'cltbld', 23:42:01 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:01 INFO - '_': '/tools/buildbot/bin/python'} 23:42:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:01 INFO - Downloading/unpacking psutil>=3.1.1 23:42:01 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:01 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:01 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:01 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:01 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:01 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:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:42:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:03 INFO - Installing collected packages: psutil 23:42:03 INFO - Running setup.py install for psutil 23:42:03 INFO - building 'psutil._psutil_linux' extension 23:42:03 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:03 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:03 INFO - building 'psutil._psutil_posix' extension 23:42:03 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:03 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:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:03 INFO - Successfully installed psutil 23:42:03 INFO - Cleaning up... 23:42:03 INFO - Return code: 0 23:42:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:42:03 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:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:03 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:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:03 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 23:42:03 INFO - 'HOME': '/home/cltbld', 23:42:03 INFO - 'LANG': 'en_US.UTF-8', 23:42:03 INFO - 'LANGUAGE': 'en_US:en', 23:42:03 INFO - 'LOGNAME': 'cltbld', 23:42:03 INFO - 'MAIL': '/var/mail/cltbld', 23:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:03 INFO - 'MOZ_NO_REMOTE': '1', 23:42:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:03 INFO - 'NO_EM_RESTART': '1', 23:42:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:03 INFO - 'PWD': '/builds/slave/test', 23:42:03 INFO - 'SHELL': '/bin/bash', 23:42:03 INFO - 'SHLVL': '1', 23:42:03 INFO - 'TERM': 'linux', 23:42:03 INFO - 'TMOUT': '86400', 23:42:03 INFO - 'USER': 'cltbld', 23:42:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:03 INFO - '_': '/tools/buildbot/bin/python'} 23:42:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:42:04 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:04 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 - 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:04 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:04 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:04 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:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:42:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:42:06 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:06 INFO - Installing collected packages: mozsystemmonitor 23:42:06 INFO - Running setup.py install for mozsystemmonitor 23:42:06 INFO - Successfully installed mozsystemmonitor 23:42:06 INFO - Cleaning up... 23:42:06 INFO - Return code: 0 23:42:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:42:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:42:06 INFO - Using env: {'DISPLAY': ':0', 23:42:06 INFO - 'HOME': '/home/cltbld', 23:42:06 INFO - 'LANG': 'en_US.UTF-8', 23:42:06 INFO - 'LANGUAGE': 'en_US:en', 23:42:06 INFO - 'LOGNAME': 'cltbld', 23:42:06 INFO - 'MAIL': '/var/mail/cltbld', 23:42:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:06 INFO - 'MOZ_NO_REMOTE': '1', 23:42:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:06 INFO - 'NO_EM_RESTART': '1', 23:42:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:06 INFO - 'PWD': '/builds/slave/test', 23:42:06 INFO - 'SHELL': '/bin/bash', 23:42:06 INFO - 'SHLVL': '1', 23:42:06 INFO - 'TERM': 'linux', 23:42:06 INFO - 'TMOUT': '86400', 23:42:06 INFO - 'USER': 'cltbld', 23:42:06 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:06 INFO - '_': '/tools/buildbot/bin/python'} 23:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:06 INFO - Downloading/unpacking jsonschema==2.5.1 23:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:42:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:08 INFO - Downloading functools32-3.2.3-2.tar.gz 23:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:42:08 INFO - warning: no files found matching '*.txt' 23:42:08 INFO - no previously-included directories found matching 'build' 23:42:08 INFO - no previously-included directories found matching 'dist' 23:42:08 INFO - no previously-included directories found matching '.git*' 23:42:08 INFO - Installing collected packages: jsonschema, functools32 23:42:08 INFO - Running setup.py install for functools32 23:42:08 INFO - warning: no files found matching '*.txt' 23:42:08 INFO - no previously-included directories found matching 'build' 23:42:08 INFO - no previously-included directories found matching 'dist' 23:42:08 INFO - no previously-included directories found matching '.git*' 23:42:08 INFO - Successfully installed jsonschema functools32 23:42:08 INFO - Cleaning up... 23:42:08 INFO - Return code: 0 23:42:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:42:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:42:08 INFO - Using env: {'DISPLAY': ':0', 23:42:08 INFO - 'HOME': '/home/cltbld', 23:42:08 INFO - 'LANG': 'en_US.UTF-8', 23:42:08 INFO - 'LANGUAGE': 'en_US:en', 23:42:08 INFO - 'LOGNAME': 'cltbld', 23:42:08 INFO - 'MAIL': '/var/mail/cltbld', 23:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:08 INFO - 'MOZ_NO_REMOTE': '1', 23:42:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:08 INFO - 'NO_EM_RESTART': '1', 23:42:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:08 INFO - 'PWD': '/builds/slave/test', 23:42:08 INFO - 'SHELL': '/bin/bash', 23:42:08 INFO - 'SHLVL': '1', 23:42:08 INFO - 'TERM': 'linux', 23:42:08 INFO - 'TMOUT': '86400', 23:42:08 INFO - 'USER': 'cltbld', 23:42:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:08 INFO - '_': '/tools/buildbot/bin/python'} 23:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:08 INFO - Downloading/unpacking blobuploader==1.2.4 23:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:10 INFO - Downloading blobuploader-1.2.4.tar.gz 23:42:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:42:10 INFO - Downloading/unpacking requests==1.2.3. (from 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:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:42:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:11 INFO - Downloading docopt-0.6.1.tar.gz 23:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:42:11 INFO - Installing collected packages: blobuploader, requests, docopt 23:42:11 INFO - Running setup.py install for blobuploader 23:42:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:42:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:42:11 INFO - Running setup.py install for requests 23:42:12 INFO - Running setup.py install for docopt 23:42:12 INFO - Successfully installed blobuploader requests docopt 23:42:12 INFO - Cleaning up... 23:42:12 INFO - Return code: 0 23:42:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:12 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:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:12 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:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:12 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:12 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:12 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:12 INFO - Using env: {'DISPLAY': ':0', 23:42:12 INFO - 'HOME': '/home/cltbld', 23:42:12 INFO - 'LANG': 'en_US.UTF-8', 23:42:12 INFO - 'LANGUAGE': 'en_US:en', 23:42:12 INFO - 'LOGNAME': 'cltbld', 23:42:12 INFO - 'MAIL': '/var/mail/cltbld', 23:42:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:12 INFO - 'MOZ_NO_REMOTE': '1', 23:42:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:12 INFO - 'NO_EM_RESTART': '1', 23:42:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:12 INFO - 'PWD': '/builds/slave/test', 23:42:12 INFO - 'SHELL': '/bin/bash', 23:42:12 INFO - 'SHLVL': '1', 23:42:12 INFO - 'TERM': 'linux', 23:42:12 INFO - 'TMOUT': '86400', 23:42:12 INFO - 'USER': 'cltbld', 23:42:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:12 INFO - '_': '/tools/buildbot/bin/python'} 23:42:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:12 INFO - Running setup.py (path:/tmp/pip-4A3HJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:12 INFO - Running setup.py (path:/tmp/pip-iBcEZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:12 INFO - Running setup.py (path:/tmp/pip-yXaWAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:12 INFO - Running setup.py (path:/tmp/pip-xEYA5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:12 INFO - Running setup.py (path:/tmp/pip-9hHP6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:12 INFO - Running setup.py (path:/tmp/pip-bxg5xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:12 INFO - Running setup.py (path:/tmp/pip-7KsbqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:12 INFO - Running setup.py (path:/tmp/pip-ae4Kk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:13 INFO - Running setup.py (path:/tmp/pip-n_10Rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:13 INFO - Running setup.py (path:/tmp/pip-s3iOwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:13 INFO - Running setup.py (path:/tmp/pip-fSnZW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:13 INFO - Running setup.py (path:/tmp/pip-Re_vMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:13 INFO - Running setup.py (path:/tmp/pip-3S339n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:13 INFO - Running setup.py (path:/tmp/pip-gXpKY3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:13 INFO - Running setup.py (path:/tmp/pip-9jqRac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:13 INFO - Running setup.py (path:/tmp/pip-fT3q5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:13 INFO - Running setup.py (path:/tmp/pip-wEMPfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:42:13 INFO - Running setup.py install for manifestparser 23:42:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:42:13 INFO - Running setup.py install for mozcrash 23:42:13 INFO - Running setup.py install for mozdebug 23:42:14 INFO - Running setup.py install for mozdevice 23:42:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Running setup.py install for mozfile 23:42:14 INFO - Running setup.py install for mozhttpd 23:42:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Running setup.py install for mozinfo 23:42:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Running setup.py install for mozInstall 23:42:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Running setup.py install for mozleak 23:42:14 INFO - Running setup.py install for mozlog 23:42:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Running setup.py install for moznetwork 23:42:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:42:14 INFO - Running setup.py install for mozprocess 23:42:14 INFO - Running setup.py install for mozprofile 23:42:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozrunner 23:42:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Running setup.py install for mozscreenshot 23:42:15 INFO - Running setup.py install for moztest 23:42:15 INFO - Running setup.py install for mozversion 23:42:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:42:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:42:15 INFO - Cleaning up... 23:42:15 INFO - Return code: 0 23:42:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:15 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:15 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:15 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:15 INFO - Using env: {'DISPLAY': ':0', 23:42:15 INFO - 'HOME': '/home/cltbld', 23:42:15 INFO - 'LANG': 'en_US.UTF-8', 23:42:15 INFO - 'LANGUAGE': 'en_US:en', 23:42:15 INFO - 'LOGNAME': 'cltbld', 23:42:15 INFO - 'MAIL': '/var/mail/cltbld', 23:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:15 INFO - 'MOZ_NO_REMOTE': '1', 23:42:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:15 INFO - 'NO_EM_RESTART': '1', 23:42:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:15 INFO - 'PWD': '/builds/slave/test', 23:42:15 INFO - 'SHELL': '/bin/bash', 23:42:15 INFO - 'SHLVL': '1', 23:42:15 INFO - 'TERM': 'linux', 23:42:15 INFO - 'TMOUT': '86400', 23:42:15 INFO - 'USER': 'cltbld', 23:42:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:15 INFO - '_': '/tools/buildbot/bin/python'} 23:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:15 INFO - Running setup.py (path:/tmp/pip-EL5bbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:15 INFO - Running setup.py (path:/tmp/pip-bxbbEI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:15 INFO - Running setup.py (path:/tmp/pip-2VAwqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:15 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:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:15 INFO - Running setup.py (path:/tmp/pip-Dq1V7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:16 INFO - Running setup.py (path:/tmp/pip-yGCacj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:16 INFO - Running setup.py (path:/tmp/pip-1IlSpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:16 INFO - Running setup.py (path:/tmp/pip-Tf_0Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:16 INFO - Running setup.py (path:/tmp/pip-IdhtHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:16 INFO - Running setup.py (path:/tmp/pip-NuDjVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:16 INFO - Running setup.py (path:/tmp/pip-_LbBhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:16 INFO - Running setup.py (path:/tmp/pip-NhdgeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:16 INFO - Running setup.py (path:/tmp/pip-EjYJZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:16 INFO - Running setup.py (path:/tmp/pip-QYE63U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:16 INFO - Running setup.py (path:/tmp/pip-yv2Hu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:16 INFO - Running setup.py (path:/tmp/pip-Xir_N6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:16 INFO - Running setup.py (path:/tmp/pip-8bUexe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:16 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:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:16 INFO - Running setup.py (path:/tmp/pip-ZSjevX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:16 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:16 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:16 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:16 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:16 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:16 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:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:42:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:18 INFO - Downloading blessings-1.6.tar.gz 23:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:42:19 INFO - Installing collected packages: blessings 23:42:19 INFO - Running setup.py install for blessings 23:42:19 INFO - Successfully installed blessings 23:42:19 INFO - Cleaning up... 23:42:19 INFO - Return code: 0 23:42:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:42:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:19 INFO - Reading from file tmpfile_stdout 23:42:19 INFO - Current package versions: 23:42:19 INFO - argparse == 1.2.1 23:42:19 INFO - blessings == 1.6 23:42:19 INFO - blobuploader == 1.2.4 23:42:19 INFO - docopt == 0.6.1 23:42:19 INFO - functools32 == 3.2.3-2 23:42:19 INFO - jsonschema == 2.5.1 23:42:19 INFO - manifestparser == 1.1 23:42:19 INFO - mozInstall == 1.12 23:42:19 INFO - mozcrash == 0.17 23:42:19 INFO - mozdebug == 0.1 23:42:19 INFO - mozdevice == 0.48 23:42:19 INFO - mozfile == 1.2 23:42:19 INFO - mozhttpd == 0.7 23:42:19 INFO - mozinfo == 0.9 23:42:19 INFO - mozleak == 0.1 23:42:19 INFO - mozlog == 3.2 23:42:19 INFO - moznetwork == 0.27 23:42:19 INFO - mozprocess == 0.22 23:42:19 INFO - mozprofile == 0.28 23:42:19 INFO - mozrunner == 6.11 23:42:19 INFO - mozscreenshot == 0.1 23:42:19 INFO - mozsystemmonitor == 0.3 23:42:19 INFO - moztest == 0.7 23:42:19 INFO - mozversion == 1.4 23:42:19 INFO - psutil == 3.1.1 23:42:19 INFO - requests == 1.2.3 23:42:19 INFO - wsgiref == 0.1.2 23:42:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:19 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 23:42:19 INFO - 'HOME': '/home/cltbld', 23:42:19 INFO - 'LANG': 'en_US.UTF-8', 23:42:19 INFO - 'LANGUAGE': 'en_US:en', 23:42:19 INFO - 'LOGNAME': 'cltbld', 23:42:19 INFO - 'MAIL': '/var/mail/cltbld', 23:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:19 INFO - 'MOZ_NO_REMOTE': '1', 23:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:19 INFO - 'NO_EM_RESTART': '1', 23:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:19 INFO - 'PWD': '/builds/slave/test', 23:42:19 INFO - 'SHELL': '/bin/bash', 23:42:19 INFO - 'SHLVL': '1', 23:42:19 INFO - 'TERM': 'linux', 23:42:19 INFO - 'TMOUT': '86400', 23:42:19 INFO - 'USER': 'cltbld', 23:42:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:19 INFO - '_': '/tools/buildbot/bin/python'} 23:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Cleaning up... 23:42:19 INFO - Return code: 0 23:42:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:42:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:19 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 23:42:19 INFO - 'HOME': '/home/cltbld', 23:42:19 INFO - 'LANG': 'en_US.UTF-8', 23:42:19 INFO - 'LANGUAGE': 'en_US:en', 23:42:19 INFO - 'LOGNAME': 'cltbld', 23:42:19 INFO - 'MAIL': '/var/mail/cltbld', 23:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:19 INFO - 'MOZ_NO_REMOTE': '1', 23:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:19 INFO - 'NO_EM_RESTART': '1', 23:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:19 INFO - 'PWD': '/builds/slave/test', 23:42:19 INFO - 'SHELL': '/bin/bash', 23:42:19 INFO - 'SHLVL': '1', 23:42:19 INFO - 'TERM': 'linux', 23:42:19 INFO - 'TMOUT': '86400', 23:42:19 INFO - 'USER': 'cltbld', 23:42:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:19 INFO - '_': '/tools/buildbot/bin/python'} 23:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:42:19 INFO - Cleaning up... 23:42:19 INFO - Return code: 0 23:42:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:42:19 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:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:19 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:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:42:19 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 0x7f9cf0cbbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x128c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x135a3b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, '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': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', '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:19 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:19 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:19 INFO - Using env: {'DISPLAY': ':0', 23:42:19 INFO - 'HOME': '/home/cltbld', 23:42:19 INFO - 'LANG': 'en_US.UTF-8', 23:42:19 INFO - 'LANGUAGE': 'en_US:en', 23:42:19 INFO - 'LOGNAME': 'cltbld', 23:42:19 INFO - 'MAIL': '/var/mail/cltbld', 23:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:19 INFO - 'MOZ_NO_REMOTE': '1', 23:42:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:19 INFO - 'NO_EM_RESTART': '1', 23:42:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:19 INFO - 'PWD': '/builds/slave/test', 23:42:19 INFO - 'SHELL': '/bin/bash', 23:42:19 INFO - 'SHLVL': '1', 23:42:19 INFO - 'TERM': 'linux', 23:42:19 INFO - 'TMOUT': '86400', 23:42:19 INFO - 'USER': 'cltbld', 23:42:19 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:19 INFO - '_': '/tools/buildbot/bin/python'} 23:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:20 INFO - Downloading/unpacking flake8 23:42:20 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:20 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 - 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:20 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:20 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:20 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 - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:42:22 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:42:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:42:22 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:42:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:42:22 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:22 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:22 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:22 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:22 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:22 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:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:42:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:42:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:42:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:42:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:42:22 INFO - no previously-included directories found matching 'docs/_build' 23:42:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:42:22 INFO - Running setup.py install for pep8 23:42:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:42:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:42:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:42:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:42:22 INFO - no previously-included directories found matching 'docs/_build' 23:42:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:42:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:42:22 INFO - Cleaning up... 23:42:22 INFO - Return code: 0 23:42:22 INFO - Running post-action listener: _resource_record_post_action 23:42:22 INFO - Running post-action listener: _start_resource_monitoring 23:42:23 INFO - Starting resource monitoring. 23:42:23 INFO - ##### 23:42:23 INFO - ##### Finished create-virtualenv step (success) 23:42:23 INFO - ##### 23:42:23 INFO - ##### 23:42:23 INFO - ##### Running install step. 23:42:23 INFO - ##### 23:42:23 INFO - Running pre-action listener: _resource_record_pre_action 23:42:23 INFO - Running main action method: install 23:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:23 INFO - Reading from file tmpfile_stdout 23:42:23 INFO - Detecting whether we're running mozinstall >=1.0... 23:42:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:42:23 INFO - Reading from file tmpfile_stdout 23:42:23 INFO - Output received: 23:42:23 INFO - Usage: mozinstall [options] installer 23:42:23 INFO - Options: 23:42:23 INFO - -h, --help show this help message and exit 23:42:23 INFO - -d DEST, --destination=DEST 23:42:23 INFO - Directory to install application into. [default: 23:42:23 INFO - "/builds/slave/test"] 23:42:23 INFO - --app=APP Application being installed. [default: firefox] 23:42:23 INFO - mkdir: /builds/slave/test/build/application 23:42:23 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:23 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:40 INFO - Reading from file tmpfile_stdout 23:42:40 INFO - Output received: 23:42:40 INFO - /builds/slave/test/build/application/firefox/firefox 23:42:40 INFO - Running post-action listener: _resource_record_post_action 23:42:40 INFO - ##### 23:42:40 INFO - ##### Finished install step (success) 23:42:40 INFO - ##### 23:42:40 INFO - ##### 23:42:40 INFO - ##### Running run-tests step. 23:42:40 INFO - ##### 23:42:40 INFO - Running pre-action listener: _resource_record_pre_action 23:42:40 INFO - Running main action method: run_tests 23:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:42:40 INFO - Python 2.7.3 23:42:40 INFO - Return code: 0 23:42:40 INFO - grabbing minidump binary from tooltool 23:42: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:42:40 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 0x13ec990>, '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 0x1358470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1358900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:42:40 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:40 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:40 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:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:42:40 INFO - Return code: 0 23:42:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:42:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:42:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:42:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:42:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:42:41 INFO - Return code: 0 23:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:42:41 INFO - Using env: {'DISPLAY': ':0', 23:42:41 INFO - 'HOME': '/home/cltbld', 23:42:41 INFO - 'LANG': 'en_US.UTF-8', 23:42:41 INFO - 'LANGUAGE': 'en_US:en', 23:42:41 INFO - 'LOGNAME': 'cltbld', 23:42:41 INFO - 'MAIL': '/var/mail/cltbld', 23:42:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:42:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:41 INFO - 'MOZ_NO_REMOTE': '1', 23:42:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:41 INFO - 'NO_EM_RESTART': '1', 23:42:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:41 INFO - 'PWD': '/builds/slave/test', 23:42:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:42:41 INFO - 'SHELL': '/bin/bash', 23:42:41 INFO - 'SHLVL': '1', 23:42:41 INFO - 'TERM': 'linux', 23:42:41 INFO - 'TMOUT': '86400', 23:42:41 INFO - 'USER': 'cltbld', 23:42:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468', 23:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:41 INFO - '_': '/tools/buildbot/bin/python'} 23:42:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DeMSWSJQQU61QRdZfTiD5Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:42:41 INFO - mozversion application_buildid: 20160608173003 23:42:41 INFO - mozversion application_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:42:41 INFO - mozversion application_display_name: Nightly 23:42:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:42:41 INFO - mozversion application_name: Firefox 23:42:41 INFO - mozversion application_remotingname: firefox 23:42:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:42:41 INFO - mozversion application_vendor: Mozilla 23:42:41 INFO - mozversion application_version: 50.0a1 23:42:41 INFO - mozversion platform_buildid: 20160608173003 23:42:41 INFO - mozversion platform_changeset: 8a447c89176fb240f78db350e8d65f62d0a6fabb 23:42:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:42:41 INFO - mozversion platform_version: 50.0a1 23:42:41 INFO - using testdate: 1465454561 23:42:41 INFO - actual date: 1465454561 23:42:41 INFO - starting webserver on 'localhost:47313' 23:42:41 INFO - SUITE-START | Running 2 tests 23:42:41 INFO - TEST-START | dromaeo_css 23:42:41 INFO - operating with platform_type : linux_ 23:42:41 INFO - Initialising browser for dromaeo_css test... 23:42:41 INFO - TEST-INFO | started process 895 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8X1MvN/profile http://localhost:47313/getInfo.html) 23:42:46 INFO - PROCESS | 895 | __metrics Screen width/height:1600/1200 23:42:46 INFO - PROCESS | 895 | colorDepth:24 23:42:46 INFO - PROCESS | 895 | Browser inner width/height: 1024/697 23:42:46 INFO - PROCESS | 895 | __metrics 23:42:47 ERROR - PROCESS | 895 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 23:42:47 INFO - TEST-INFO | 895: exit 0 23:42:47 INFO - Browser initialized. 23:42:47 INFO - Running cycle 1/1 for dromaeo_css test... 23:42:47 INFO - TEST-INFO | started process 1015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8X1MvN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:42:59 INFO - PROCESS | 1015 | RSS: Main: 167391232 23:42:59 INFO - PROCESS | 1015 | 23:43:49 INFO - PROCESS | 1015 | 1465454629418 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:45:57 INFO - PROCESS | 1015 | Cycle 1(1): loaded http://localhost:47313/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47313/tests/dromaeo/cssquery-ext.html) 23:45:58 INFO - PROCESS | 1015 | RSS: Main: 171249664 23:45:58 INFO - PROCESS | 1015 | 23:49:00 INFO - PROCESS | 1015 | Cycle 1(1): loaded http://localhost:47313/tests/dromaeo/cssquery-ext.html (next: http://localhost:47313/tests/dromaeo/cssquery-jquery.html) 23:49:00 INFO - PROCESS | 1015 | RSS: Main: 170110976 23:49:00 INFO - PROCESS | 1015 | 23:52:02 INFO - PROCESS | 1015 | Cycle 1(1): loaded http://localhost:47313/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47313/tests/dromaeo/cssquery-mootools.html) 23:52:03 INFO - PROCESS | 1015 | RSS: Main: 171327488 23:52:03 INFO - PROCESS | 1015 | 23:55:05 INFO - PROCESS | 1015 | Cycle 1(1): loaded http://localhost:47313/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47313/tests/dromaeo/cssquery-prototype.html) 23:55:05 INFO - PROCESS | 1015 | RSS: Main: 168550400 23:55:05 INFO - PROCESS | 1015 | 23:58:08 INFO - PROCESS | 1015 | Cycle 1(1): loaded http://localhost:47313/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47313/tests/dromaeo/cssquery-yui.html) 23:58:08 INFO - PROCESS | 1015 | RSS: Main: 170786816 23:58:08 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | Cycle 1(1): loaded http://localhost:47313/tests/dromaeo/cssquery-yui.html (next: http://localhost:47313/tests/dromaeo/cssquery-dojo.html) 00:01:11 INFO - PROCESS | 1015 | RSS: Main: 179900416 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | __start_tp_report 00:01:11 INFO - PROCESS | 1015 | _x_x_mozilla_page_load 00:01:11 INFO - PROCESS | 1015 | _x_x_mozilla_page_load_details 00:01:11 INFO - PROCESS | 1015 | |i|pagename|runs| 00:01:11 INFO - PROCESS | 1015 | |0;dojo.html;3136.702013308736;3171.223050352664;3195.5845740053787;3202.5516427700118;3210.6628803975595;5269.262303277545;5322.6008049396305;5383.650062745924;5424.430434804348;5439.945600543993;5279.076161671711;5331.520163185312;5391.16436952272;5441.211024401459;5448.046591846431;4874.147024270747;4909.926351104737;5004.224345226496;5028.49715028496;5067.594592432615;4902.3872015998;5056.241563765446;5062.493750624945;5066.544011039005;5077.84766457005;4851.393575803042;4895.412550493964;4908.410990681141;4943.1102401567705;4955.603551715854;4901.754912254409;4904.975475122637;4922.138625740481;4922.926156107661;4928.556429921288;4826.927596086061;4828.927566086511;4842.1526232909455;4887.413510378778;4912.091263116335;5140.228965655144;5269.314989051437;5271.894562108736;5300.655457395295;5382.865428364283;5693.202951586781;5726.713664316768;5740.196372507852;5762.222100016528;5766.192733017381;5608.4111168327145;5801.187833703285;5802.564807639444;5812.273465816773;5851.268591426072;5316.149416093445;5321.494458026481;5358.303420555342;5362.946370536322;5368.087425137697;5833.445822646841;5886.175935369051;5917.112433135064;5948.613340132878;5964.463198312086;5570.220169176318;5656.349519805192;5709.0865461525955;5730.312362516524;5734.168545560954;5693.829185124453;5802.245708057925;5828.941710582924;5839.941600584025;5887.4406931341455;5600.047991841397;5763.711814409263;5774.220480235114;5779.537636989031;5783.363829978699;5557.166425036277;5740.282464691913;5792.9420705793245;5792.9420705793245;5826.446487583673;4315.568443155722;4339.045410009793;4405.757683327448;4408.4269045024585;4408.58118478744;3948.2498325318097;3951.4665520154413;3951.881443556698;3975.045988962686;3999.280129576704;5516.365617953907;5524.944750552523;5529.115341545334;5535.750891209906;5570.554355651539;5826.6795326256615;5834.066549352084;5850.824475265749;5864.120381942743;5884.117382392676;5565.860853478614;5571.303587051619;5574.080276754371;5574.442555744474;5577.3028371453565;4914.311996320518;4976.2286845539;5011.448740638527;5011.824586139468;5026.070177017264;5969.194158788508;5981.880362392728;6005.39946005396;6022.969885150546;6038.728257228435;5887.411258874078;5894.263217097863;5899.528037756883;5900.144479050599;5904.9704751475965;5865.384134665798;5967.791127310524;5975.342712301556;6008.789692360747;6058.5758996871555;5744.913826292693;5749.511291540099;5762.279715035621;5762.740676669644;5766.798162064308;5754.913676294943;5893.6463812171405;5895.528357731457;5902.203202567598;5903.085021821625;5651.095824668033;5678.659280443187;5681;5692.231548740867;5719;5485.314335708036;5585.106382978704;5623.690697011703;5628.1557766333735;5704;5564.860878478071;5592.916106258491;5597.916031259616;5611.130274807411;5630.071038278638;5600.0479918414785;5656.745446455002;5657.094864821609;5706.400827913009;5764.682942438206;5592.7203639817035;5613.382527922007;5629.54963602919;5635.520980716685;5644.266245388073 00:01:11 INFO - PROCESS | 1015 | |1;ext.html;567.937526872044;612.3080918562024;617.7251123250153;621.0994058615008;649.0977541217705;40053.599464005354;44761;45301.32048019274;45363;45535.54464455354;44930.77534612322;45096.09807803842;45291.77354113225;45349.09301813962;45614;8782.824343513126;8982.146696063863;8995.235404990584;8998.775030624221;9002.369834111614;8744.956275218616;8866.822663546725;8882.86675699865;8888.688895888645;8901.109889011112;8971.596278167466;8977.775555611097;9013.95493022534;9017;9025.18773310402;8854.734357969304;8927.285817134614;8930.598123084445;8931.464112153226;8940.463572185625;8876.511791851446;8973.910260897437;8995.280377569845;8996.280297576179;9027.14242146995;43141.35287970683;43194.352084718754;43459.13081738379;43470;43672.12655746867;3355.1947532592003;3440.17435815405;3476.8261586920808;3540.398132317512;3945.1912357966835;31987.6801231987;32653.38756908563;33060.17349566256;33080;33267.66732332694;4260.169266992938;4322.330038843984;4402.889927751799;4509.842155524541;4591.242444996572;363467;364384;365284;365921;366015;61113.08330375048;61554.38445615576;61634.691826540584;62184.378156217856;62441.37558624447;65957.34042659609;66191;66253.33746662471;66262.33737662659;66597.33402666009;17165.65668686644;17415;17603.295868165387;17605.911970440324;17632.03023833676;12991.610251692275;13205.73588528224;13216.867831321755;13267.601971940858;13279.269640169883;17969.446706215356;18061.2775488979;18827.81172188288;19004.52488687766;19242.615147696968;6305.4009869062365;6556.967215163893;6617.503687223478;6633.1045308882685;6760.42536384403;1008.391650158782;1014.2139841622654;1039.5685790397051;1073.8711354637494;1076.7523469602036;32855.87869152427;32959.67040329614;33040.66959330424;33340;33828.49257261143;1131.4964840645835;1140.378493720924;1211.8666946635863;1221.2977537915733;1281.8974482041415;17571.912140439217;17595.912020439817;17702.29190832378;17728.822711772977;17738.733918991227;561254;566330;571194;571562;571998;59514;59525.70237148787;59678.10482842761;59713.10430343548;59922.70038649779;1316.1247770232878;1356.6404902700792;1389.9861001389856;1421.0549984260558;1427.3719563392074;31482.212944676565;32257.838710806296;32513.975952883513;32540.186495337806;32907.67092329046;52670.473295268086;52855.207171891685;53277.73361133169;53363.99999999845;53495.465045350604;347894;348251;348724;351432;352430;27868.30329241785;28483.857580711963;28817;43666;43895.12209755723;49055.7547212276;49988.75005624948;50137;50717.746411267704;51134.48865511446;41837.79081104575;43018.56981430146;43190.78404607957;43617.345739813296;43812.561874380845;42450.150996980505;42489;42641.36037959371;42651;43325;38880.61119388883;39313.606863930996;40600.1879962405;42246;42561.78719106385;36185;38979.41530876982;38990.80504597459;39276;39525;28866.567001494575;28998.710012899603;29307.85346073256;29326.04826194478;29353.266168345108 00:01:11 INFO - PROCESS | 1015 | |2;jquery.html;374.34115955917594;376.4954960353126;381.07969254250986;386.65587627011945;397.6282176165284;15284.847151528482;17718.421144635187;19730.309439169632;19928;20009.59980800383;18995.620087598276;19155.712664310013;20019.899900500513;20066.59866802667;20083.297084602043;5217.634765566412;5636.4927156555905;5686.601937864351;5699.800506982257;5711.8000869969555;5412.648177868446;5547.0570003099365;5676.801311954083;5678.261825962619;5765.625234359774;5696.316442026962;5733.397993210715;5742.7415766290615;6208.565400421972;6438.163038804949;6400.103985442041;6423.132877061584;6437.324080971524;6437.935620643781;6451.06459563363;5493.642913210629;5657.519110875581;5693.430656934315;5711.971440142773;5719.571032172604;14035.85964140366;14151.433942642281;14197.219152946584;19626.313079042164;22349.553008939893;2204.481946742514;2223.555288942218;2307.10023090993;2471.480988992296;2554.3997160667227;9806.754831129207;10404.32371895832;10481.161507079416;10526.631567895163;10631.574737010511;1861.5811442425481;1956.207735866962;1968.8917109558968;1983.4049785064567;2135.6049130910833;79295.6035219826;80541.19458805396;81265;81352.59323703403;82125.58937205275;10802.459877006118;11095;11382.203245772882;11412.372319522507;11417.543298268143;13600.523981660594;13980.44078236859;14379;15894.76157857633;15936.681266374608;8285.544295063708;8291.95854020726;8359.331253499706;8434.072252052269;8604.225619694258;8011.679532818622;8050.637721302555;8228.588570571448;8280.130586288473;8313.792155196048;4753.643476739189;4764.595009424238;4787.066522028171;4916.287138364989;4956.90086198274;1903.4184043472635;1929.4501067195781;1994.8204661580528;2009.4574464894397;2016.9193232270839;952.9523523823781;979.1481411172325;1010.3382284603597;1016.6899095775859;1019.5768755966191;18108.094595270184;18486.907565462356;18770.436886893414;19057.523561911064;19358.903205484163;942.9245660347293;954.9659225848898;961.6009356117133;1024.3700124423426;1031.293563908725;10355.159164659322;10599.152067834555;10610.628627997983;10703.732406689895;10791;492441;502515;503738;511330;513832;90222.54888725646;91494;91924.54037729769;91978.54010730037;92405.53797230971;993.458565082032;996.3872218585518;1023.8515415264745;1033.7312298802365;1038.3302769713493;17191.65616687684;17411.303547857944;17555.736663949796;17581.384651537133;17585.736213957058;31990.36019279555;38993.685536729696;39665.206695865345;40502.79748601238;40542.39186412147;56536.71731641315;58693.11960320684;58867;59064.40935590589;59690;7379.298966598165;7846.254605812439;8731.781705457415;8746.73759787182;8757.605907734294;12880.871191287968;13326.267055312052;13337.133086349357;13492;13586.592402227949;5720.3707592165665;8751.693690720795;11611.245269057485;11701.186316121015;11975.341356225492;10976;11649.650510484698;11998;12122.818157727464;12131.150819442555;11884.286942783461;11901.82147267809;12023.45894434735;12050;12118.939405302917;8784.604692788967;8843.867341990004;8870.86693699582;9015.594298256463;9041.05068967749;8768.25469835071;10878.40168790724;11455.427228638368;11763.588274410355;12033.338166400932 00:01:11 INFO - PROCESS | 1015 | |3;mootools.html;1454.2219912346893;1458.0522660270822;1621.7324141516651;1782.483079906827;1787.3297513432456;7834.334081603056;8444.366672499564;8448.23965843074;9072.954635226823;9084.182423581868;8748.912510874889;8784.297256219503;8825.602847871845;8833.558322083902;8834.337424693158;2304.078368652544;2321.3036089173265;2331.6502524621274;2338.2634470141934;2339.4502291961376;2277.7266727992665;2305.5849947009533;2315.560043591712;2316.837821352506;2317.316391664463;2228.253535065755;2234.441389652587;2248.8763118028583;2255.244493094807;2284.4060544258446;2156.8382371322214;2157.6332023555956;2157.6763485477227;2164.729408823897;2171.923982660607;2173.8695678259355;2189.37602783206;2220.5114874727697;2266.0142837865415;2271.2845453682203;8805.911940880638;8815.779605509913;8835.867461988075;8836.823263534694;8843.11568843117;5110.463401342842;5280.973595132038;5286.762095705702;5288.576913846883;5301.973490132563;3253.96746032539;3319.5684561007156;3465;3466.445368740989;3475.3570589441033;1151.9712007199887;1163.4008485629906;1171.2796630072444;1186.3356520348545;1195.2051885496135;12478.064145189148;12485.812712809224;12522.186057906207;12544.435500402504;12614.55849045279;4516.07420478801;4547.067851090518;4608.746518941491;4638.930416043694;4688.320193571913;10452.11157051644;10474.423906685053;10480.63317783874;10494.317869338469;10520.105791007696;5286;5318.973405133027;5337.386200586982;5339.759710813023;5345.278387417648;4064.146529228836;4746.644001699887;4856.368672072608;4870.1233777920315;4885.755712214375;3706.4069748840056;3749.7937613430977;3822.503074600284;3857.0743021675157;3861.864834730827;1194.0745921910589;1215.95136194553;1220.45079714129;1220.9572664956684;1245.035097799213;991.5984026469291;1000.7197984564334;1012.2307046644456;1024.5799222318813;1029.8661174047477;6016.8796624068145;6114.357992410822;6164.321924588292;6204.441600255998;6256.405641464054;440.8831659610206;444.07853703564587;444.8420810612251;447.57480393625536;447.5993985383064;4293.3130699088;4344.152890186447;4349.3475978603465;4362.934555981663;4383.671224658164;10561.155107591374;10819.404932728776;10875.401852898009;10878.456077196108;10888.346699198073;10206.23453240995;10714.517846696917;10857.239993200401;10860.076893463985;10890.29213101146;7946.205379462123;8241.011078670477;8302.460340077876;8347.29048030912;8387.329013678891;5945.167676525376;6353.237611486651;6368.0766288886925;6389.233292004989;6412.326705695835;10005.699829005142;10198.388096714221;10242.283040187116;10374.429406382722;10376.584936602754;10137.138343240907;10142.746431339276;10308;10355.482225888825;10421.739456513647;7314.37827784623;7361.1166660001145;7494.400447964041;7988;8134.186581341818;8204.548749818818;8241.587920604066;8248.257656810916;8262.049864265446;8312.750617481484;7230.819229519304;7242.855142897218;7414.295641914009;7516.624168791429;7574.242575742382;7144.106986626672;7422.255769893963;7443.627818608939;7513.812154696177;7538.208488108669;6951;6952.409045231212;6989.825254368681;6990.685419156049;6997.755078572429;5060.114479966065;5108.795648174031;5171.663841850268;5237.292965449616;5268.841934741964;5091.694498330112;5187.766550505161;5190.273361729285;5195.610329225247;5227.712475813867 00:01:11 INFO - PROCESS | 1015 | |4;prototype.html;330.09553822526277;333.77470207609866;335.81865792472064;342.1531709020177;342.5666531837226;5589.357223919251;5643.774249030044;5671.241915006351;5683.744231509581;5685.602007859451;5538.529225015878;5572.693501857396;5579.330480342354;5581.944180558193;5624.662520248788;4168.478940132483;4177.979110104445;4314.784260786963;4323.286657701491;4325.610695037446;4285.550017248191;4307.418498502693;4312.525622181557;4321.416608757809;4344.891377715567;4272.722273052257;4336.522982471925;4338;4348.478182618091;4367.104743527585;4067.9593204068174;4305.655547556188;4314.331278651814;4323.329883868006;4354.17270718564;3748.456473811282;3749.906252343686;3751.5873253942045;3770.7171962102952;3784.9621503784883;5368.677879327214;5389.461053894618;5435.728213589305;5435.918461223085;5470.905818836249;4873.220284754422;4884.902301953976;4945.2582112683385;4951.044337486673;4966.056449274663;5804.477597016246;5809.477147056743;5821.7380217890295;5856.76572937082;5876.4123587641325;4107.788202480276;4149.128682976549;4178.456800615901;4179.874603761861;4198.706090573661;5885.764569417218;6059.848503787396;6075.574709770318;6084.695765211766;6174.9073763893575;4218.620324170839;4219.303814870512;4228.682848786353;4233.243204070338;4241.936370954438;4239.830406783694;4293.978530107392;4296;4299.355096735452;4300.4194433751045;4653.302004699254;4900.411950565884;4922.33548470959;4940.7895065709135;4946.777395017233;5849.912251316234;5893;5893.2044174035955;5895.94104058954;5937.198478205473;1464.7183714250032;1478.7412202864455;1495.4765831958946;1496.5659958612098;1499.0705762427365;945.5933948402115;950.273041123541;988.6243227573476;997.6907158780801;1001.1990407673832;5624.775008999676;5625.634333768292;5647.632903861236;5652.406497317723;5681.261436013292;5967.283925928917;5996.970015149896;6008.939910600925;6015.759369625253;6020.247469066367;5465.289512363367;5673.461021202979;5731.8853622928145;5734.254546908875;5738.569607279471;3200.887968921123;3202.2314644485155;3229.935401291961;3236.1585987643384;3250.268689544881;6118.632882027093;6183.412575805291;6209.379062093845;6246.188605304502;6311.431971122621;6153.538484613672;6173.228346456693;6183.598066125687;6206.751729930843;6207.410296021871;6026.186464827279;6211.3167551569295;6261.311255761862;6324.620522768557;6324.841878952971;5943.257092863392;6043.2748070231855;6078.817635470943;6099.9390006099375;6103.816885493442;5990.88018239624;5991.281046274475;6020.458158765732;6042.939570604413;6054.122152287806;6009.819705408845;6246.125542424155;6262.530310226843;6308.369163083838;6308.873822523616;4269.573042695705;4277.101808620225;4299.118680670517;4300.698951073395;4314.201872653569;5588.3573389060775;6096.664683442275;6113.633182009094;6132.846678833065;6165.475934545614;5822.243108395882;5827.155062515996;5850.882982340244;5853.2976042875125;5857.5313974881055;5842.415758424124;5866.562692140453;5877.970610147093;5884.117382392676;5915.25499977499;5454.372747133972;5669.688167150846;5672.914906276326;5722.7710891563875;5738.799142030009;5836.824895253149;5892.499137573354;5930.318013428511;5933.724249286424;5952.821415357546;5508.980838544882;5735.5087677205065;5766.740496677576;5771.68255745938;5773.769049237983 00:01:11 INFO - PROCESS | 1015 | |5;yui.html;747.353539188602;768.5004746914504;804.4208170117513;809.7125520440244;856.687309132167;14321.785173222397;15487.148206848618;15493.302801373922;15494.767578486331;15519.84480155198;13373.59879203623;13916.582502524916;13952.720945581083;14189.71620567588;14251.714965700705;801.5631480842925;819.5001049359886;822.8313195794848;825.1871906172415;826.8304997475503;803.863343231652;811.4968719393954;811.9391045671568;815.2418251026543;817.1215942861447;859.4327743689166;863.8617821148617;865.7446053414227;865.9956700216491;866.514751739025;850.5619605902965;852.7271273192581;852.86780549015;857.7769779857251;859.0893652728097;624.188554878656;629.232336549409;629.5781826176473;629.7134803664321;630.1052505442237;13597.728045439037;13703.794443083361;13730.45078196871;13810.516631917935;14281.14313141215;14746.11523308605;14749.26253687322;14845.480408185662;14920.806335493135;14977.475788347465;12093.274403535816;12118.39408029595;12292.569760058444;12391.690207744788;12669.113162078658;3804.8566704515906;3906;3951.4467974483596;3971.4837071180564;4074.9812546863286;80649.59675201586;80782;81458.37083258302;82317.58841205755;82445.58777206196;11296.887031129583;11410.258333208314;11466.541338346373;11629.88370116305;11661.883381166079;22120.778792211873;22282.55434891293;22302.665460018114;22316.218932337615;22323;8442.366822488339;8752;8905.109489051172;8931.240844528158;9139.268858491305;4743.739094349844;4755.262934245128;4822;4945.431275403303;5033.043721692867;3735.6264373562426;3873.573906870242;3875.9418608720894;3877.5540812806325;3887.455756194135;588.355750453253;590.1855439493557;593.851537115721;604.5073265288776;611.2512172588544;557.799192290775;737.7786664000778;764.3159372361816;768.2739810878666;797.9800504987305;10453.216008799218;10615.363078215332;10745.194110441747;10892.346459212473;10893.945530272298;626.8434737908551;664.64773669955;719.1873183302939;757.443279189795;775.83707421441;4772.785224664898;4868.756562171877;4886.291487734258;4905.435874874435;4947.431045429822;113590.43204784089;114241.42879285717;114944.42527787475;116210.12213961908;118242;84527.5773621128;85919.57040214883;91124;100789;102410.48794755978;76133.85799213016;88675.11324886669;89580.5520972404;91883.32466701257;93485;9572.856407153758;9590.42457452555;9782.608695652094;9807.607695692377;9811.166050885755;50136.74931625318;51256.23115653343;52167.21749173841;52875;52896;45612;75617;75659.62170189114;76165.23834761581;77585.22414776006;12826.166299190523;12939.158954667917;13053.151545149534;13072.150310229805;13321.400536975665;14402.639934001734;14488.492902748354;14568.635784105481;14926.402943882124;15302.081875087086;13622.318884055956;13644.795328070286;13957.162570245819;14070;14317.427302907767;13826.170429774245;14247.572572822832;14582.19797911125;14842.554723358317;14977.400903963719;13394;13833.723325533232;13846.93076534611;13998.860011399756;14079.788803167756;10971.177161713063;11216.831747523956;11435.942820285845;11638.06895448379;11770.58802941893;11380.487878045673;11531.135164862837;11678.24091434054;11887;11968.581099661471 00:01:11 INFO - PROCESS | 1015 | __end_tp_report 00:01:11 INFO - PROCESS | 1015 | __start_cc_report 00:01:11 INFO - PROCESS | 1015 | _x_x_mozilla_cycle_collect,342 00:01:11 INFO - PROCESS | 1015 | __end_cc_report 00:01:11 INFO - PROCESS | 1015 | __startTimestamp1465455671966__endTimestamp 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | ------- Summary: start ------- 00:01:11 INFO - PROCESS | 1015 | Number of tests: 6 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | [#0] dojo.html Cycles:165 Average:5382.44 Median:5597.92 stddev:609.64 (10.9%) stddev-sans-first:585.50 00:01:11 INFO - PROCESS | 1015 | Values: 3136.7 3171.2 3195.6 3202.6 3210.7 5269.3 5322.6 5383.7 5424.4 5439.9 5279.1 5331.5 5391.2 5441.2 5448.0 4874.1 4909.9 5004.2 5028.5 5067.6 4902.4 5056.2 5062.5 5066.5 5077.8 4851.4 4895.4 4908.4 4943.1 4955.6 4901.8 4905.0 4922.1 4922.9 4928.6 4826.9 4828.9 4842.2 4887.4 4912.1 5140.2 5269.3 5271.9 5300.7 5382.9 5693.2 5726.7 5740.2 5762.2 5766.2 5608.4 5801.2 5802.6 5812.3 5851.3 5316.1 5321.5 5358.3 5362.9 5368.1 5833.4 5886.2 5917.1 5948.6 5964.5 5570.2 5656.3 5709.1 5730.3 5734.2 5693.8 5802.2 5828.9 5839.9 5887.4 5600.0 5763.7 5774.2 5779.5 5783.4 5557.2 5740.3 5792.9 5792.9 5826.4 4315.6 4339.0 4405.8 4408.4 4408.6 3948.2 3951.5 3951.9 3975.0 3999.3 5516.4 5524.9 5529.1 5535.8 5570.6 5826.7 5834.1 5850.8 5864.1 5884.1 5565.9 5571.3 5574.1 5574.4 5577.3 4914.3 4976.2 5011.4 5011.8 5026.1 5969.2 5981.9 6005.4 6023.0 6038.7 5887.4 5894.3 5899.5 5900.1 5905.0 5865.4 5967.8 5975.3 6008.8 6058.6 5744.9 5749.5 5762.3 5762.7 5766.8 5754.9 5893.6 5895.5 5902.2 5903.1 5651.1 5678.7 5681.0 5692.2 5719.0 5485.3 5585.1 5623.7 5628.2 5704.0 5564.9 5592.9 5597.9 5611.1 5630.1 5600.0 5656.7 5657.1 5706.4 5764.7 5592.7 5613.4 5629.5 5635.5 5644.3 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | [#1] ext.html Cycles:180 Average:60132.17 Median:43079.96 stddev:116434.82 (270.3%) stddev-sans-first:116675.56 00:01:11 INFO - PROCESS | 1015 | Values: 567.9 612.3 617.7 621.1 649.1 40053.6 44761.0 45301.3 45363.0 45535.5 44930.8 45096.1 45291.8 45349.1 45614.0 8782.8 8982.1 8995.2 8998.8 9002.4 8745.0 8866.8 8882.9 8888.7 8901.1 8971.6 8977.8 9014.0 9017.0 9025.2 8854.7 8927.3 8930.6 8931.5 8940.5 8876.5 8973.9 8995.3 8996.3 9027.1 43141.4 43194.4 43459.1 43470.0 43672.1 3355.2 3440.2 3476.8 3540.4 3945.2 31987.7 32653.4 33060.2 33080.0 33267.7 4260.2 4322.3 4402.9 4509.8 4591.2 363467.0 364384.0 365284.0 365921.0 366015.0 61113.1 61554.4 61634.7 62184.4 62441.4 65957.3 66191.0 66253.3 66262.3 66597.3 17165.7 17415.0 17603.3 17605.9 17632.0 12991.6 13205.7 13216.9 13267.6 13279.3 17969.4 18061.3 18827.8 19004.5 19242.6 6305.4 6557.0 6617.5 6633.1 6760.4 1008.4 1014.2 1039.6 1073.9 1076.8 32855.9 32959.7 33040.7 33340.0 33828.5 1131.5 1140.4 1211.9 1221.3 1281.9 17571.9 17595.9 17702.3 17728.8 17738.7 561254.0 566330.0 571194.0 571562.0 571998.0 59514.0 59525.7 59678.1 59713.1 59922.7 1316.1 1356.6 1390.0 1421.1 1427.4 31482.2 32257.8 32514.0 32540.2 32907.7 52670.5 52855.2 53277.7 53364.0 53495.5 347894.0 348251.0 348724.0 351432.0 352430.0 27868.3 28483.9 28817.0 43666.0 43895.1 49055.8 49988.8 50137.0 50717.7 51134.5 41837.8 43018.6 43190.8 43617.3 43812.6 42450.2 42489.0 42641.4 42651.0 43325.0 38880.6 39313.6 40600.2 42246.0 42561.8 36185.0 38979.4 38990.8 39276.0 39525.0 28866.6 28998.7 29307.9 29326.0 29353.3 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | [#2] jquery.html Cycles:180 Average:29112.04 Median:375.42 stddev:83168.71 (22153.6%) stddev-sans-first:83374.03 00:01:11 INFO - PROCESS | 1015 | Values: 374.3 376.5 381.1 386.7 397.6 15284.8 17718.4 19730.3 19928.0 20009.6 18995.6 19155.7 20019.9 20066.6 20083.3 5217.6 5636.5 5686.6 5699.8 5711.8 5412.6 5547.1 5676.8 5678.3 5765.6 5696.3 5733.4 5742.7 6208.6 6438.2 6400.1 6423.1 6437.3 6437.9 6451.1 5493.6 5657.5 5693.4 5712.0 5719.6 14035.9 14151.4 14197.2 19626.3 22349.6 2204.5 2223.6 2307.1 2471.5 2554.4 9806.8 10404.3 10481.2 10526.6 10631.6 1861.6 1956.2 1968.9 1983.4 2135.6 79295.6 80541.2 81265.0 81352.6 82125.6 10802.5 11095.0 11382.2 11412.4 11417.5 13600.5 13980.4 14379.0 15894.8 15936.7 8285.5 8292.0 8359.3 8434.1 8604.2 8011.7 8050.6 8228.6 8280.1 8313.8 4753.6 4764.6 4787.1 4916.3 4956.9 1903.4 1929.5 1994.8 2009.5 2016.9 953.0 979.1 1010.3 1016.7 1019.6 18108.1 18486.9 18770.4 19057.5 19358.9 942.9 955.0 961.6 1024.4 1031.3 10355.2 10599.2 10610.6 10703.7 10791.0 492441.0 502515.0 503738.0 511330.0 513832.0 90222.5 91494.0 91924.5 91978.5 92405.5 993.5 996.4 1023.9 1033.7 1038.3 17191.7 17411.3 17555.7 17581.4 17585.7 31990.4 38993.7 39665.2 40502.8 40542.4 56536.7 58693.1 58867.0 59064.4 59690.0 7379.3 7846.3 8731.8 8746.7 8757.6 12880.9 13326.3 13337.1 13492.0 13586.6 5720.4 8751.7 11611.2 11701.2 11975.3 10976.0 11649.7 11998.0 12122.8 12131.2 11884.3 11901.8 12023.5 12050.0 12118.9 8784.6 8843.9 8870.9 9015.6 9041.1 8768.3 10878.4 11455.4 11763.6 12033.3 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | [#3] mootools.html Cycles:180 Average:5781.29 Median:442.48 stddev:3322.65 (750.9%) stddev-sans-first:3316.06 00:01:11 INFO - PROCESS | 1015 | Values: 1454.2 1458.1 1621.7 1782.5 1787.3 7834.3 8444.4 8448.2 9073.0 9084.2 8748.9 8784.3 8825.6 8833.6 8834.3 2304.1 2321.3 2331.7 2338.3 2339.5 2277.7 2305.6 2315.6 2316.8 2317.3 2228.3 2234.4 2248.9 2255.2 2284.4 2156.8 2157.6 2157.7 2164.7 2171.9 2173.9 2189.4 2220.5 2266.0 2271.3 8805.9 8815.8 8835.9 8836.8 8843.1 5110.5 5281.0 5286.8 5288.6 5302.0 3254.0 3319.6 3465.0 3466.4 3475.4 1152.0 1163.4 1171.3 1186.3 1195.2 12478.1 12485.8 12522.2 12544.4 12614.6 4516.1 4547.1 4608.7 4638.9 4688.3 10452.1 10474.4 10480.6 10494.3 10520.1 5286.0 5319.0 5337.4 5339.8 5345.3 4064.1 4746.6 4856.4 4870.1 4885.8 3706.4 3749.8 3822.5 3857.1 3861.9 1194.1 1216.0 1220.5 1221.0 1245.0 991.6 1000.7 1012.2 1024.6 1029.9 6016.9 6114.4 6164.3 6204.4 6256.4 440.9 444.1 444.8 447.6 447.6 4293.3 4344.2 4349.3 4362.9 4383.7 10561.2 10819.4 10875.4 10878.5 10888.3 10206.2 10714.5 10857.2 10860.1 10890.3 7946.2 8241.0 8302.5 8347.3 8387.3 5945.2 6353.2 6368.1 6389.2 6412.3 10005.7 10198.4 10242.3 10374.4 10376.6 10137.1 10142.7 10308.0 10355.5 10421.7 7314.4 7361.1 7494.4 7988.0 8134.2 8204.5 8241.6 8248.3 8262.0 8312.8 7230.8 7242.9 7414.3 7516.6 7574.2 7144.1 7422.3 7443.6 7513.8 7538.2 6951.0 6952.4 6989.8 6990.7 6997.8 5060.1 5108.8 5171.7 5237.3 5268.8 5091.7 5187.8 5190.3 5195.6 5227.7 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | [#4] prototype.html Cycles:180 Average:4928.58 Median:5661.05 stddev:1466.59 (25.9%) stddev-sans-first:1429.51 00:01:11 INFO - PROCESS | 1015 | Values: 330.1 333.8 335.8 342.2 342.6 5589.4 5643.8 5671.2 5683.7 5685.6 5538.5 5572.7 5579.3 5581.9 5624.7 4168.5 4178.0 4314.8 4323.3 4325.6 4285.6 4307.4 4312.5 4321.4 4344.9 4272.7 4336.5 4338.0 4348.5 4367.1 4068.0 4305.7 4314.3 4323.3 4354.2 3748.5 3749.9 3751.6 3770.7 3785.0 5368.7 5389.5 5435.7 5435.9 5470.9 4873.2 4884.9 4945.3 4951.0 4966.1 5804.5 5809.5 5821.7 5856.8 5876.4 4107.8 4149.1 4178.5 4179.9 4198.7 5885.8 6059.8 6075.6 6084.7 6174.9 4218.6 4219.3 4228.7 4233.2 4241.9 4239.8 4294.0 4296.0 4299.4 4300.4 4653.3 4900.4 4922.3 4940.8 4946.8 5849.9 5893.0 5893.2 5895.9 5937.2 1464.7 1478.7 1495.5 1496.6 1499.1 945.6 950.3 988.6 997.7 1001.2 5624.8 5625.6 5647.6 5652.4 5681.3 5967.3 5997.0 6008.9 6015.8 6020.2 5465.3 5673.5 5731.9 5734.3 5738.6 3200.9 3202.2 3229.9 3236.2 3250.3 6118.6 6183.4 6209.4 6246.2 6311.4 6153.5 6173.2 6183.6 6206.8 6207.4 6026.2 6211.3 6261.3 6324.6 6324.8 5943.3 6043.3 6078.8 6099.9 6103.8 5990.9 5991.3 6020.5 6042.9 6054.1 6009.8 6246.1 6262.5 6308.4 6308.9 4269.6 4277.1 4299.1 4300.7 4314.2 5588.4 6096.7 6113.6 6132.8 6165.5 5822.2 5827.2 5850.9 5853.3 5857.5 5842.4 5866.6 5878.0 5884.1 5915.3 5454.4 5669.7 5672.9 5722.8 5738.8 5836.8 5892.5 5930.3 5933.7 5952.8 5509.0 5735.5 5766.7 5771.7 5773.8 00:01:11 INFO - PROCESS | 1015 | 00:01:11 INFO - PROCESS | 1015 | [#5] yui.html Cycles:180 Average:20848.62 Median:4023.23 stddev:29802.86 (740.8%) stddev-sans-first:29848.25 00:01:11 INFO - PROCESS | 1015 | Values: 747.4 768.5 804.4 809.7 856.7 14321.8 15487.1 15493.3 15494.8 15519.8 13373.6 13916.6 13952.7 14189.7 14251.7 801.6 819.5 822.8 825.2 826.8 803.9 811.5 811.9 815.2 817.1 859.4 863.9 865.7 866.0 866.5 850.6 852.7 852.9 857.8 859.1 624.2 629.2 629.6 629.7 630.1 13597.7 13703.8 13730.5 13810.5 14281.1 14746.1 14749.3 14845.5 14920.8 14977.5 12093.3 12118.4 12292.6 12391.7 12669.1 3804.9 3906.0 3951.4 3971.5 4075.0 80649.6 80782.0 81458.4 82317.6 82445.6 11296.9 11410.3 11466.5 11629.9 11661.9 22120.8 22282.6 22302.7 22316.2 22323.0 8442.4 8752.0 8905.1 8931.2 9139.3 4743.7 4755.3 4822.0 4945.4 5033.0 3735.6 3873.6 3875.9 3877.6 3887.5 588.4 590.2 593.9 604.5 611.3 557.8 737.8 764.3 768.3 798.0 10453.2 10615.4 10745.2 10892.3 10893.9 626.8 664.6 719.2 757.4 775.8 4772.8 4868.8 4886.3 4905.4 4947.4 113590.4 114241.4 114944.4 116210.1 118242.0 84527.6 85919.6 91124.0 100789.0 102410.5 76133.9 88675.1 89580.6 91883.3 93485.0 9572.9 9590.4 9782.6 9807.6 9811.2 50136.7 51256.2 52167.2 52875.0 52896.0 45612.0 75617.0 75659.6 76165.2 77585.2 12826.2 12939.2 13053.2 13072.2 13321.4 14402.6 14488.5 14568.6 14926.4 15302.1 13622.3 13644.8 13957.2 14070.0 14317.4 13826.2 14247.6 14582.2 14842.6 14977.4 13394.0 13833.7 13846.9 13998.9 14079.8 10971.2 11216.8 11435.9 11638.1 11770.6 11380.5 11531.1 11678.2 11887.0 11968.6 00:01:11 INFO - PROCESS | 1015 | -------- Summary: end -------- 00:01:11 INFO - PROCESS | 1015 | 00:01:12 INFO - TEST-INFO | 1015: exit 0 00:01:12 INFO - TEST-OK | dromaeo_css | took 1111292ms 00:01:12 INFO - TEST-START | kraken 00:01:12 INFO - operating with platform_type : linux_ 00:01:12 INFO - Initialising browser for kraken test... 00:01:12 INFO - TEST-INFO | started process 1335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcmALP/profile http://localhost:47313/getInfo.html) 00:01:17 INFO - PROCESS | 1335 | __metrics Screen width/height:1600/1200 00:01:17 INFO - PROCESS | 1335 | colorDepth:24 00:01:17 INFO - PROCESS | 1335 | Browser inner width/height: 1024/697 00:01:17 INFO - PROCESS | 1335 | __metrics 00:01:17 ERROR - PROCESS | 1335 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 00:01:18 INFO - TEST-INFO | 1335: exit 0 00:01:18 INFO - Browser initialized. 00:01:18 INFO - Running cycle 1/1 for kraken test... 00:01:18 INFO - TEST-INFO | started process 1454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDcmALP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:01:30 INFO - PROCESS | 1454 | RSS: Main: 167264256 00:01:30 INFO - PROCESS | 1454 | 00:01:33 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47313/tests/kraken/driver.html?testName=audio-beat-detection) 00:01:33 INFO - PROCESS | 1454 | RSS: Main: 172634112 00:01:33 INFO - PROCESS | 1454 | 00:01:36 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47313/tests/kraken/driver.html?testName=audio-dft) 00:01:37 INFO - PROCESS | 1454 | RSS: Main: 171888640 00:01:37 INFO - PROCESS | 1454 | 00:01:40 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47313/tests/kraken/driver.html?testName=audio-fft) 00:01:40 INFO - PROCESS | 1454 | RSS: Main: 166846464 00:01:40 INFO - PROCESS | 1454 | 00:01:43 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47313/tests/kraken/driver.html?testName=audio-oscillator) 00:01:43 INFO - PROCESS | 1454 | RSS: Main: 167526400 00:01:43 INFO - PROCESS | 1454 | 00:01:45 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47313/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:01:46 INFO - PROCESS | 1454 | RSS: Main: 167432192 00:01:46 INFO - PROCESS | 1454 | 00:01:49 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47313/tests/kraken/driver.html?testName=imaging-darkroom) 00:01:50 INFO - PROCESS | 1454 | RSS: Main: 168222720 00:01:50 INFO - PROCESS | 1454 | 00:01:53 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47313/tests/kraken/driver.html?testName=imaging-desaturate) 00:01:54 INFO - PROCESS | 1454 | RSS: Main: 166244352 00:01:54 INFO - PROCESS | 1454 | 00:01:57 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47313/tests/kraken/driver.html?testName=json-parse-financial) 00:01:57 INFO - PROCESS | 1454 | RSS: Main: 166981632 00:01:57 INFO - PROCESS | 1454 | 00:01:59 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47313/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:01:59 INFO - PROCESS | 1454 | RSS: Main: 167489536 00:01:59 INFO - PROCESS | 1454 | 00:02:01 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:02:02 INFO - PROCESS | 1454 | RSS: Main: 167698432 00:02:02 INFO - PROCESS | 1454 | 00:02:04 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:02:05 INFO - PROCESS | 1454 | RSS: Main: 168394752 00:02:05 INFO - PROCESS | 1454 | 00:02:07 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:02:08 INFO - PROCESS | 1454 | RSS: Main: 168419328 00:02:08 INFO - PROCESS | 1454 | 00:02:11 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:02:11 INFO - PROCESS | 1454 | RSS: Main: 168062976 00:02:11 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | Cycle 1(1): loaded http://localhost:47313/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47313/tests/kraken/driver.html?testName=ai-astar) 00:02:13 INFO - PROCESS | 1454 | RSS: Main: 168562688 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | __start_tp_report 00:02:13 INFO - PROCESS | 1454 | _x_x_mozilla_page_load 00:02:13 INFO - PROCESS | 1454 | _x_x_mozilla_page_load_details 00:02:13 INFO - PROCESS | 1454 | |i|pagename|runs| 00:02:13 INFO - PROCESS | 1454 | |0;ai-astar;112;107;113;113;113;115;112;110;111;113 00:02:13 INFO - PROCESS | 1454 | |1;audio-beat-detection;164;128;161;182;128;158;160;135;174;127 00:02:13 INFO - PROCESS | 1454 | |2;audio-dft;162;164;162;165;164;170;166;162;164;164 00:02:13 INFO - PROCESS | 1454 | |3;audio-fft;75;76;77;158;78;77;75;76;154;76 00:02:13 INFO - PROCESS | 1454 | |4;audio-oscillator;86;85;140;85;85;85;129;85;85;141 00:02:13 INFO - PROCESS | 1454 | |5;imaging-gaussian-blur;117;117;117;118;117;118;118;119;117;117 00:02:13 INFO - PROCESS | 1454 | |6;imaging-darkroom;148;147;147;148;146;147;151;149;146;148 00:02:13 INFO - PROCESS | 1454 | |7;imaging-desaturate;97;96;96;96;95;96;96;96;96;96 00:02:13 INFO - PROCESS | 1454 | |8;json-parse-financial;58;57;56;57;61;60;61;60;58;62 00:02:13 INFO - PROCESS | 1454 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;61;62;61 00:02:13 INFO - PROCESS | 1454 | |10;stanford-crypto-aes;79;80;84;81;81;80;81;87;106;81 00:02:13 INFO - PROCESS | 1454 | |11;stanford-crypto-ccm;132;130;123;121;126;132;127;127;133;136 00:02:13 INFO - PROCESS | 1454 | |12;stanford-crypto-pbkdf2;158;164;158;162;163;159;159;157;158;161 00:02:13 INFO - PROCESS | 1454 | |13;stanford-crypto-sha256-iterative;66;63;73;66;62;63;64;65;62;64 00:02:13 INFO - PROCESS | 1454 | __end_tp_report 00:02:13 INFO - PROCESS | 1454 | __start_cc_report 00:02:13 INFO - PROCESS | 1454 | _x_x_mozilla_cycle_collect,884 00:02:13 INFO - PROCESS | 1454 | __end_cc_report 00:02:13 INFO - PROCESS | 1454 | __startTimestamp1465455733625__endTimestamp 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | ------- Summary: start ------- 00:02:13 INFO - PROCESS | 1454 | Number of tests: 14 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.18 (1.9%) stddev-sans-first:2.32 00:02:13 INFO - PROCESS | 1454 | Values: 112.0 107.0 113.0 113.0 113.0 115.0 112.0 110.0 111.0 113.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:160.50 stddev:20.48 (12.8%) stddev-sans-first:21.23 00:02:13 INFO - PROCESS | 1454 | Values: 164.0 128.0 161.0 182.0 128.0 158.0 160.0 135.0 174.0 127.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.41 (1.5%) stddev-sans-first:2.40 00:02:13 INFO - PROCESS | 1454 | Values: 162.0 164.0 162.0 165.0 164.0 170.0 166.0 162.0 164.0 164.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#3] audio-fft Cycles:10 Average:92.20 Median:76.00 stddev:33.65 (44.3%) stddev-sans-first:35.11 00:02:13 INFO - PROCESS | 1454 | Values: 75.0 76.0 77.0 158.0 78.0 77.0 75.0 76.0 154.0 76.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#4] audio-oscillator Cycles:10 Average:100.60 Median:85.00 stddev:25.09 (29.5%) stddev-sans-first:26.05 00:02:13 INFO - PROCESS | 1454 | Values: 86.0 85.0 140.0 85.0 85.0 85.0 129.0 85.0 85.0 141.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 00:02:13 INFO - PROCESS | 1454 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 118.0 119.0 117.0 117.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.49 (1.0%) stddev-sans-first:1.58 00:02:13 INFO - PROCESS | 1454 | Values: 148.0 147.0 147.0 148.0 146.0 147.0 151.0 149.0 146.0 148.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 00:02:13 INFO - PROCESS | 1454 | Values: 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:60.00 stddev:2.05 (3.4%) stddev-sans-first:2.15 00:02:13 INFO - PROCESS | 1454 | Values: 58.0 57.0 56.0 57.0 61.0 60.0 61.0 60.0 58.0 62.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 00:02:13 INFO - PROCESS | 1454 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 61.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:81.00 stddev:8.07 (10.0%) stddev-sans-first:8.35 00:02:13 INFO - PROCESS | 1454 | Values: 79.0 80.0 84.0 81.0 81.0 80.0 81.0 87.0 106.0 81.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:131.00 stddev:4.72 (3.6%) stddev-sans-first:4.85 00:02:13 INFO - PROCESS | 1454 | Values: 132.0 130.0 123.0 121.0 126.0 132.0 127.0 127.0 133.0 136.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:160.00 stddev:2.42 (1.5%) stddev-sans-first:2.47 00:02:13 INFO - PROCESS | 1454 | Values: 158.0 164.0 158.0 162.0 163.0 159.0 159.0 157.0 158.0 161.0 00:02:13 INFO - PROCESS | 1454 | 00:02:13 INFO - PROCESS | 1454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:64.50 stddev:3.22 (5.0%) stddev-sans-first:3.39 00:02:13 INFO - PROCESS | 1454 | Values: 66.0 63.0 73.0 66.0 62.0 63.0 64.0 65.0 62.0 64.0 00:02:13 INFO - PROCESS | 1454 | -------- Summary: end -------- 00:02:13 INFO - PROCESS | 1454 | 00:02:14 INFO - TEST-INFO | 1454: exit 0 00:02:14 INFO - TEST-OK | kraken | took 61871ms 00:02:14 INFO - SUITE-END | took 1173s 00:02:14 INFO - Completed test suite (00:19:33) 00:02:14 INFO - javascript benchmark 00:02:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7335.573347917348, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.702013308736, 3171.223050352664, 3195.5845740053787, 3202.5516427700118, 3210.6628803975595, 5269.262303277545, 5322.6008049396305, 5383.650062745924, 5424.430434804348, 5439.945600543993, 5279.076161671711, 5331.520163185312, 5391.16436952272, 5441.211024401459, 5448.046591846431, 4874.147024270747, 4909.926351104737, 5004.224345226496, 5028.49715028496, 5067.594592432615, 4902.3872015998, 5056.241563765446, 5062.493750624945, 5066.544011039005, 5077.84766457005, 4851.393575803042, 4895.412550493964, 4908.410990681141, 4943.1102401567705, 4955.603551715854, 4901.754912254409, 4904.975475122637, 4922.138625740481, 4922.926156107661, 4928.556429921288, 4826.927596086061, 4828.927566086511, 4842.1526232909455, 4887.413510378778, 4912.091263116335, 5140.228965655144, 5269.314989051437, 5271.894562108736, 5300.655457395295, 5382.865428364283, 5693.202951586781, 5726.713664316768, 5740.196372507852, 5762.222100016528, 5766.192733017381, 5608.4111168327145, 5801.187833703285, 5802.564807639444, 5812.273465816773, 5851.268591426072, 5316.149416093445, 5321.494458026481, 5358.303420555342, 5362.946370536322, 5368.087425137697, 5833.445822646841, 5886.175935369051, 5917.112433135064, 5948.613340132878, 5964.463198312086, 5570.220169176318, 5656.349519805192, 5709.0865461525955, 5730.312362516524, 5734.168545560954, 5693.829185124453, 5802.245708057925, 5828.941710582924, 5839.941600584025, 5887.4406931341455, 5600.047991841397, 5763.711814409263, 5774.220480235114, 5779.537636989031, 5783.363829978699, 5557.166425036277, 5740.282464691913, 5792.9420705793245, 5792.9420705793245, 5826.446487583673, 4315.568443155722, 4339.045410009793, 4405.757683327448, 4408.4269045024585, 4408.58118478744, 3948.2498325318097, 3951.4665520154413, 3951.881443556698, 3975.045988962686, 3999.280129576704, 5516.365617953907, 5524.944750552523, 5529.115341545334, 5535.750891209906, 5570.554355651539, 5826.6795326256615, 5834.066549352084, 5850.824475265749, 5864.120381942743, 5884.117382392676, 5565.860853478614, 5571.303587051619, 5574.080276754371, 5574.442555744474, 5577.3028371453565, 4914.311996320518, 4976.2286845539, 5011.448740638527, 5011.824586139468, 5026.070177017264, 5969.194158788508, 5981.880362392728, 6005.39946005396, 6022.969885150546, 6038.728257228435, 5887.411258874078, 5894.263217097863, 5899.528037756883, 5900.144479050599, 5904.9704751475965, 5865.384134665798, 5967.791127310524, 5975.342712301556, 6008.789692360747, 6058.5758996871555, 5744.913826292693, 5749.511291540099, 5762.279715035621, 5762.740676669644, 5766.798162064308, 5754.913676294943, 5893.6463812171405, 5895.528357731457, 5902.203202567598, 5903.085021821625, 5651.095824668033, 5678.659280443187, 5681.0, 5692.231548740867, 5719.0, 5485.314335708036, 5585.106382978704, 5623.690697011703, 5628.1557766333735, 5704.0, 5564.860878478071, 5592.916106258491, 5597.916031259616, 5611.130274807411, 5630.071038278638, 5600.0479918414785, 5656.745446455002, 5657.094864821609, 5706.400827913009, 5764.682942438206, 5592.7203639817035, 5613.382527922007, 5629.54963602919, 5635.520980716685, 5644.266245388073], "value": 5341.717351565556, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.937526872044, 612.3080918562024, 617.7251123250153, 621.0994058615008, 649.0977541217705, 40053.599464005354, 44761.0, 45301.32048019274, 45363.0, 45535.54464455354, 44930.77534612322, 45096.09807803842, 45291.77354113225, 45349.09301813962, 45614.0, 8782.824343513126, 8982.146696063863, 8995.235404990584, 8998.775030624221, 9002.369834111614, 8744.956275218616, 8866.822663546725, 8882.86675699865, 8888.688895888645, 8901.109889011112, 8971.596278167466, 8977.775555611097, 9013.95493022534, 9017.0, 9025.18773310402, 8854.734357969304, 8927.285817134614, 8930.598123084445, 8931.464112153226, 8940.463572185625, 8876.511791851446, 8973.910260897437, 8995.280377569845, 8996.280297576179, 9027.14242146995, 43141.35287970683, 43194.352084718754, 43459.13081738379, 43470.0, 43672.12655746867, 3355.1947532592003, 3440.17435815405, 3476.8261586920808, 3540.398132317512, 3945.1912357966835, 31987.6801231987, 32653.38756908563, 33060.17349566256, 33080.0, 33267.66732332694, 4260.169266992938, 4322.330038843984, 4402.889927751799, 4509.842155524541, 4591.242444996572, 363467.0, 364384.0, 365284.0, 365921.0, 366015.0, 61113.08330375048, 61554.38445615576, 61634.691826540584, 62184.378156217856, 62441.37558624447, 65957.34042659609, 66191.0, 66253.33746662471, 66262.33737662659, 66597.33402666009, 17165.65668686644, 17415.0, 17603.295868165387, 17605.911970440324, 17632.03023833676, 12991.610251692275, 13205.73588528224, 13216.867831321755, 13267.601971940858, 13279.269640169883, 17969.446706215356, 18061.2775488979, 18827.81172188288, 19004.52488687766, 19242.615147696968, 6305.4009869062365, 6556.967215163893, 6617.503687223478, 6633.1045308882685, 6760.42536384403, 1008.391650158782, 1014.2139841622654, 1039.5685790397051, 1073.8711354637494, 1076.7523469602036, 32855.87869152427, 32959.67040329614, 33040.66959330424, 33340.0, 33828.49257261143, 1131.4964840645835, 1140.378493720924, 1211.8666946635863, 1221.2977537915733, 1281.8974482041415, 17571.912140439217, 17595.912020439817, 17702.29190832378, 17728.822711772977, 17738.733918991227, 561254.0, 566330.0, 571194.0, 571562.0, 571998.0, 59514.0, 59525.70237148787, 59678.10482842761, 59713.10430343548, 59922.70038649779, 1316.1247770232878, 1356.6404902700792, 1389.9861001389856, 1421.0549984260558, 1427.3719563392074, 31482.212944676565, 32257.838710806296, 32513.975952883513, 32540.186495337806, 32907.67092329046, 52670.473295268086, 52855.207171891685, 53277.73361133169, 53363.99999999845, 53495.465045350604, 347894.0, 348251.0, 348724.0, 351432.0, 352430.0, 27868.30329241785, 28483.857580711963, 28817.0, 43666.0, 43895.12209755723, 49055.7547212276, 49988.75005624948, 50137.0, 50717.746411267704, 51134.48865511446, 41837.79081104575, 43018.56981430146, 43190.78404607957, 43617.345739813296, 43812.561874380845, 42450.150996980505, 42489.0, 42641.36037959371, 42651.0, 43325.0, 38880.61119388883, 39313.606863930996, 40600.1879962405, 42246.0, 42561.78719106385, 36185.0, 38979.41530876982, 38990.80504597459, 39276.0, 39525.0, 28866.567001494575, 28998.710012899603, 29307.85346073256, 29326.04826194478, 29353.266168345108], "value": 20603.383540638817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.34115955917594, 376.4954960353126, 381.07969254250986, 386.65587627011945, 397.6282176165284, 15284.847151528482, 17718.421144635187, 19730.309439169632, 19928.0, 20009.59980800383, 18995.620087598276, 19155.712664310013, 20019.899900500513, 20066.59866802667, 20083.297084602043, 5217.634765566412, 5636.4927156555905, 5686.601937864351, 5699.800506982257, 5711.8000869969555, 5412.648177868446, 5547.0570003099365, 5676.801311954083, 5678.261825962619, 5765.625234359774, 5696.316442026962, 5733.397993210715, 5742.7415766290615, 6208.565400421972, 6438.163038804949, 6400.103985442041, 6423.132877061584, 6437.324080971524, 6437.935620643781, 6451.06459563363, 5493.642913210629, 5657.519110875581, 5693.430656934315, 5711.971440142773, 5719.571032172604, 14035.85964140366, 14151.433942642281, 14197.219152946584, 19626.313079042164, 22349.553008939893, 2204.481946742514, 2223.555288942218, 2307.10023090993, 2471.480988992296, 2554.3997160667227, 9806.754831129207, 10404.32371895832, 10481.161507079416, 10526.631567895163, 10631.574737010511, 1861.5811442425481, 1956.207735866962, 1968.8917109558968, 1983.4049785064567, 2135.6049130910833, 79295.6035219826, 80541.19458805396, 81265.0, 81352.59323703403, 82125.58937205275, 10802.459877006118, 11095.0, 11382.203245772882, 11412.372319522507, 11417.543298268143, 13600.523981660594, 13980.44078236859, 14379.0, 15894.76157857633, 15936.681266374608, 8285.544295063708, 8291.95854020726, 8359.331253499706, 8434.072252052269, 8604.225619694258, 8011.679532818622, 8050.637721302555, 8228.588570571448, 8280.130586288473, 8313.792155196048, 4753.643476739189, 4764.595009424238, 4787.066522028171, 4916.287138364989, 4956.90086198274, 1903.4184043472635, 1929.4501067195781, 1994.8204661580528, 2009.4574464894397, 2016.9193232270839, 952.9523523823781, 979.1481411172325, 1010.3382284603597, 1016.6899095775859, 1019.5768755966191, 18108.094595270184, 18486.907565462356, 18770.436886893414, 19057.523561911064, 19358.903205484163, 942.9245660347293, 954.9659225848898, 961.6009356117133, 1024.3700124423426, 1031.293563908725, 10355.159164659322, 10599.152067834555, 10610.628627997983, 10703.732406689895, 10791.0, 492441.0, 502515.0, 503738.0, 511330.0, 513832.0, 90222.54888725646, 91494.0, 91924.54037729769, 91978.54010730037, 92405.53797230971, 993.458565082032, 996.3872218585518, 1023.8515415264745, 1033.7312298802365, 1038.3302769713493, 17191.65616687684, 17411.303547857944, 17555.736663949796, 17581.384651537133, 17585.736213957058, 31990.36019279555, 38993.685536729696, 39665.206695865345, 40502.79748601238, 40542.39186412147, 56536.71731641315, 58693.11960320684, 58867.0, 59064.40935590589, 59690.0, 7379.298966598165, 7846.254605812439, 8731.781705457415, 8746.73759787182, 8757.605907734294, 12880.871191287968, 13326.267055312052, 13337.133086349357, 13492.0, 13586.592402227949, 5720.3707592165665, 8751.693690720795, 11611.245269057485, 11701.186316121015, 11975.341356225492, 10976.0, 11649.650510484698, 11998.0, 12122.818157727464, 12131.150819442555, 11884.286942783461, 11901.82147267809, 12023.45894434735, 12050.0, 12118.939405302917, 8784.604692788967, 8843.867341990004, 8870.86693699582, 9015.594298256463, 9041.05068967749, 8768.25469835071, 10878.40168790724, 11455.427228638368, 11763.588274410355, 12033.338166400932], "value": 9127.231663925026, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.2219912346893, 1458.0522660270822, 1621.7324141516651, 1782.483079906827, 1787.3297513432456, 7834.334081603056, 8444.366672499564, 8448.23965843074, 9072.954635226823, 9084.182423581868, 8748.912510874889, 8784.297256219503, 8825.602847871845, 8833.558322083902, 8834.337424693158, 2304.078368652544, 2321.3036089173265, 2331.6502524621274, 2338.2634470141934, 2339.4502291961376, 2277.7266727992665, 2305.5849947009533, 2315.560043591712, 2316.837821352506, 2317.316391664463, 2228.253535065755, 2234.441389652587, 2248.8763118028583, 2255.244493094807, 2284.4060544258446, 2156.8382371322214, 2157.6332023555956, 2157.6763485477227, 2164.729408823897, 2171.923982660607, 2173.8695678259355, 2189.37602783206, 2220.5114874727697, 2266.0142837865415, 2271.2845453682203, 8805.911940880638, 8815.779605509913, 8835.867461988075, 8836.823263534694, 8843.11568843117, 5110.463401342842, 5280.973595132038, 5286.762095705702, 5288.576913846883, 5301.973490132563, 3253.96746032539, 3319.5684561007156, 3465.0, 3466.445368740989, 3475.3570589441033, 1151.9712007199887, 1163.4008485629906, 1171.2796630072444, 1186.3356520348545, 1195.2051885496135, 12478.064145189148, 12485.812712809224, 12522.186057906207, 12544.435500402504, 12614.55849045279, 4516.07420478801, 4547.067851090518, 4608.746518941491, 4638.930416043694, 4688.320193571913, 10452.11157051644, 10474.423906685053, 10480.63317783874, 10494.317869338469, 10520.105791007696, 5286.0, 5318.973405133027, 5337.386200586982, 5339.759710813023, 5345.278387417648, 4064.146529228836, 4746.644001699887, 4856.368672072608, 4870.1233777920315, 4885.755712214375, 3706.4069748840056, 3749.7937613430977, 3822.503074600284, 3857.0743021675157, 3861.864834730827, 1194.0745921910589, 1215.95136194553, 1220.45079714129, 1220.9572664956684, 1245.035097799213, 991.5984026469291, 1000.7197984564334, 1012.2307046644456, 1024.5799222318813, 1029.8661174047477, 6016.8796624068145, 6114.357992410822, 6164.321924588292, 6204.441600255998, 6256.405641464054, 440.8831659610206, 444.07853703564587, 444.8420810612251, 447.57480393625536, 447.5993985383064, 4293.3130699088, 4344.152890186447, 4349.3475978603465, 4362.934555981663, 4383.671224658164, 10561.155107591374, 10819.404932728776, 10875.401852898009, 10878.456077196108, 10888.346699198073, 10206.23453240995, 10714.517846696917, 10857.239993200401, 10860.076893463985, 10890.29213101146, 7946.205379462123, 8241.011078670477, 8302.460340077876, 8347.29048030912, 8387.329013678891, 5945.167676525376, 6353.237611486651, 6368.0766288886925, 6389.233292004989, 6412.326705695835, 10005.699829005142, 10198.388096714221, 10242.283040187116, 10374.429406382722, 10376.584936602754, 10137.138343240907, 10142.746431339276, 10308.0, 10355.482225888825, 10421.739456513647, 7314.37827784623, 7361.1166660001145, 7494.400447964041, 7988.0, 8134.186581341818, 8204.548749818818, 8241.587920604066, 8248.257656810916, 8262.049864265446, 8312.750617481484, 7230.819229519304, 7242.855142897218, 7414.295641914009, 7516.624168791429, 7574.242575742382, 7144.106986626672, 7422.255769893963, 7443.627818608939, 7513.812154696177, 7538.208488108669, 6951.0, 6952.409045231212, 6989.825254368681, 6990.685419156049, 6997.755078572429, 5060.114479966065, 5108.795648174031, 5171.663841850268, 5237.292965449616, 5268.841934741964, 5091.694498330112, 5187.766550505161, 5190.273361729285, 5195.610329225247, 5227.712475813867], "value": 4540.62702303311, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.09553822526277, 333.77470207609866, 335.81865792472064, 342.1531709020177, 342.5666531837226, 5589.357223919251, 5643.774249030044, 5671.241915006351, 5683.744231509581, 5685.602007859451, 5538.529225015878, 5572.693501857396, 5579.330480342354, 5581.944180558193, 5624.662520248788, 4168.478940132483, 4177.979110104445, 4314.784260786963, 4323.286657701491, 4325.610695037446, 4285.550017248191, 4307.418498502693, 4312.525622181557, 4321.416608757809, 4344.891377715567, 4272.722273052257, 4336.522982471925, 4338.0, 4348.478182618091, 4367.104743527585, 4067.9593204068174, 4305.655547556188, 4314.331278651814, 4323.329883868006, 4354.17270718564, 3748.456473811282, 3749.906252343686, 3751.5873253942045, 3770.7171962102952, 3784.9621503784883, 5368.677879327214, 5389.461053894618, 5435.728213589305, 5435.918461223085, 5470.905818836249, 4873.220284754422, 4884.902301953976, 4945.2582112683385, 4951.044337486673, 4966.056449274663, 5804.477597016246, 5809.477147056743, 5821.7380217890295, 5856.76572937082, 5876.4123587641325, 4107.788202480276, 4149.128682976549, 4178.456800615901, 4179.874603761861, 4198.706090573661, 5885.764569417218, 6059.848503787396, 6075.574709770318, 6084.695765211766, 6174.9073763893575, 4218.620324170839, 4219.303814870512, 4228.682848786353, 4233.243204070338, 4241.936370954438, 4239.830406783694, 4293.978530107392, 4296.0, 4299.355096735452, 4300.4194433751045, 4653.302004699254, 4900.411950565884, 4922.33548470959, 4940.7895065709135, 4946.777395017233, 5849.912251316234, 5893.0, 5893.2044174035955, 5895.94104058954, 5937.198478205473, 1464.7183714250032, 1478.7412202864455, 1495.4765831958946, 1496.5659958612098, 1499.0705762427365, 945.5933948402115, 950.273041123541, 988.6243227573476, 997.6907158780801, 1001.1990407673832, 5624.775008999676, 5625.634333768292, 5647.632903861236, 5652.406497317723, 5681.261436013292, 5967.283925928917, 5996.970015149896, 6008.939910600925, 6015.759369625253, 6020.247469066367, 5465.289512363367, 5673.461021202979, 5731.8853622928145, 5734.254546908875, 5738.569607279471, 3200.887968921123, 3202.2314644485155, 3229.935401291961, 3236.1585987643384, 3250.268689544881, 6118.632882027093, 6183.412575805291, 6209.379062093845, 6246.188605304502, 6311.431971122621, 6153.538484613672, 6173.228346456693, 6183.598066125687, 6206.751729930843, 6207.410296021871, 6026.186464827279, 6211.3167551569295, 6261.311255761862, 6324.620522768557, 6324.841878952971, 5943.257092863392, 6043.2748070231855, 6078.817635470943, 6099.9390006099375, 6103.816885493442, 5990.88018239624, 5991.281046274475, 6020.458158765732, 6042.939570604413, 6054.122152287806, 6009.819705408845, 6246.125542424155, 6262.530310226843, 6308.369163083838, 6308.873822523616, 4269.573042695705, 4277.101808620225, 4299.118680670517, 4300.698951073395, 4314.201872653569, 5588.3573389060775, 6096.664683442275, 6113.633182009094, 6132.846678833065, 6165.475934545614, 5822.243108395882, 5827.155062515996, 5850.882982340244, 5853.2976042875125, 5857.5313974881055, 5842.415758424124, 5866.562692140453, 5877.970610147093, 5884.117382392676, 5915.25499977499, 5454.372747133972, 5669.688167150846, 5672.914906276326, 5722.7710891563875, 5738.799142030009, 5836.824895253149, 5892.499137573354, 5930.318013428511, 5933.724249286424, 5952.821415357546, 5508.980838544882, 5735.5087677205065, 5766.740496677576, 5771.68255745938, 5773.769049237983], "value": 4456.228048735754, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.353539188602, 768.5004746914504, 804.4208170117513, 809.7125520440244, 856.687309132167, 14321.785173222397, 15487.148206848618, 15493.302801373922, 15494.767578486331, 15519.84480155198, 13373.59879203623, 13916.582502524916, 13952.720945581083, 14189.71620567588, 14251.714965700705, 801.5631480842925, 819.5001049359886, 822.8313195794848, 825.1871906172415, 826.8304997475503, 803.863343231652, 811.4968719393954, 811.9391045671568, 815.2418251026543, 817.1215942861447, 859.4327743689166, 863.8617821148617, 865.7446053414227, 865.9956700216491, 866.514751739025, 850.5619605902965, 852.7271273192581, 852.86780549015, 857.7769779857251, 859.0893652728097, 624.188554878656, 629.232336549409, 629.5781826176473, 629.7134803664321, 630.1052505442237, 13597.728045439037, 13703.794443083361, 13730.45078196871, 13810.516631917935, 14281.14313141215, 14746.11523308605, 14749.26253687322, 14845.480408185662, 14920.806335493135, 14977.475788347465, 12093.274403535816, 12118.39408029595, 12292.569760058444, 12391.690207744788, 12669.113162078658, 3804.8566704515906, 3906.0, 3951.4467974483596, 3971.4837071180564, 4074.9812546863286, 80649.59675201586, 80782.0, 81458.37083258302, 82317.58841205755, 82445.58777206196, 11296.887031129583, 11410.258333208314, 11466.541338346373, 11629.88370116305, 11661.883381166079, 22120.778792211873, 22282.55434891293, 22302.665460018114, 22316.218932337615, 22323.0, 8442.366822488339, 8752.0, 8905.109489051172, 8931.240844528158, 9139.268858491305, 4743.739094349844, 4755.262934245128, 4822.0, 4945.431275403303, 5033.043721692867, 3735.6264373562426, 3873.573906870242, 3875.9418608720894, 3877.5540812806325, 3887.455756194135, 588.355750453253, 590.1855439493557, 593.851537115721, 604.5073265288776, 611.2512172588544, 557.799192290775, 737.7786664000778, 764.3159372361816, 768.2739810878666, 797.9800504987305, 10453.216008799218, 10615.363078215332, 10745.194110441747, 10892.346459212473, 10893.945530272298, 626.8434737908551, 664.64773669955, 719.1873183302939, 757.443279189795, 775.83707421441, 4772.785224664898, 4868.756562171877, 4886.291487734258, 4905.435874874435, 4947.431045429822, 113590.43204784089, 114241.42879285717, 114944.42527787475, 116210.12213961908, 118242.0, 84527.5773621128, 85919.57040214883, 91124.0, 100789.0, 102410.48794755978, 76133.85799213016, 88675.11324886669, 89580.5520972404, 91883.32466701257, 93485.0, 9572.856407153758, 9590.42457452555, 9782.608695652094, 9807.607695692377, 9811.166050885755, 50136.74931625318, 51256.23115653343, 52167.21749173841, 52875.0, 52896.0, 45612.0, 75617.0, 75659.62170189114, 76165.23834761581, 77585.22414776006, 12826.166299190523, 12939.158954667917, 13053.151545149534, 13072.150310229805, 13321.400536975665, 14402.639934001734, 14488.492902748354, 14568.635784105481, 14926.402943882124, 15302.081875087086, 13622.318884055956, 13644.795328070286, 13957.162570245819, 14070.0, 14317.427302907767, 13826.170429774245, 14247.572572822832, 14582.19797911125, 14842.554723358317, 14977.400903963719, 13394.0, 13833.723325533232, 13846.93076534611, 13998.860011399756, 14079.788803167756, 10971.177161713063, 11216.831747523956, 11435.942820285845, 11638.06895448379, 11770.58802941893, 11380.487878045673, 11531.135164862837, 11678.24091434054, 11887.0, 11968.581099661471], "value": 7665.105375460754, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 113.0, 113.0, 113.0, 115.0, 112.0, 110.0, 111.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 161.0, 182.0, 128.0, 158.0, 160.0, 135.0, 174.0, 127.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 165.0, 164.0, 170.0, 166.0, 162.0, 164.0, 164.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 158.0, 78.0, 77.0, 75.0, 76.0, 154.0, 76.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 140.0, 85.0, 85.0, 85.0, 129.0, 85.0, 85.0, 141.0], "value": 100.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 148.0, 146.0, 147.0, 151.0, 149.0, 146.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 56.0, 57.0, 61.0, 60.0, 61.0, 60.0, 58.0, 62.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 84.0, 81.0, 81.0, 80.0, 81.0, 87.0, 106.0, 81.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 130.0, 123.0, 121.0, 126.0, 132.0, 127.0, 127.0, 133.0, 136.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 164.0, 158.0, 162.0, 163.0, 159.0, 159.0, 157.0, 158.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 73.0, 66.0, 62.0, 63.0, 64.0, 65.0, 62.0, 64.0], "value": 64.8, "unit": "score"}]}]} 00:02:14 INFO - Return code: 0 00:02:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:02:14 ERROR - # TBPL SUCCESS # 00:02:14 INFO - Running post-action listener: _resource_record_post_action 00:02:14 INFO - ##### 00:02:14 INFO - ##### Finished run-tests step (success) 00:02:14 INFO - ##### 00:02:14 INFO - Running post-run listener: _resource_record_post_run 00:02:15 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542093312; Read time: 12; Write time: 494436 00:02:15 INFO - TinderboxPrint: CPU usage
13.5% 00:02:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:02:15 INFO - TinderboxPrint: I/O write bytes / time
542,093,312 / 494,436 00:02:15 INFO - TinderboxPrint: CPU idle
8,220.2 (86.5%) 00:02:15 INFO - TinderboxPrint: CPU user
1,226.5 (12.9%) 00:02:15 INFO - TinderboxPrint: Swap in / out
0 / 0 00:02:15 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248303616; Read time: 0; Write time: 261440 00:02:15 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293789696; Read time: 12; Write time: 232996 00:02:15 INFO - Running post-run listener: _upload_blobber_files 00:02:15 INFO - Blob upload gear active. 00:02:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:02:15 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:15 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:15 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:15 INFO - (blobuploader) - INFO - Open directory for files ... 00:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:16 INFO - (blobuploader) - INFO - Done attempting. 00:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:02:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:22 INFO - (blobuploader) - INFO - Done attempting. 00:02:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:02:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:02:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:23 INFO - (blobuploader) - INFO - Done attempting. 00:02:23 INFO - (blobuploader) - INFO - Iteration through files over. 00:02:23 INFO - Return code: 0 00:02:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:02:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:02:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee72654fd5c73eaf63951f355c7a12ec29d2613fd7745b6d81fdaf0faa31942a1e5eeca73403737c6fd11b4be1909e506209a45d8429f753434f16327f364fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5d09f2a8a4aa31877554f8265e887f5b6fba26144669ece551c55d994e401c27f3d2677ab939d3412734e75e412c4d1e9c1867737876144101eebbc493375be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5f8115eb0d62ce026686cfee4511fb111c763d52a1bacd31a6d80aa3a095a197174e4802ebb5a63a5df9498a88785691ee15ef8af06ff8d498fb4b4b318c883"} 00:02:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:02:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:02:23 INFO - Contents: 00:02:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee72654fd5c73eaf63951f355c7a12ec29d2613fd7745b6d81fdaf0faa31942a1e5eeca73403737c6fd11b4be1909e506209a45d8429f753434f16327f364fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5d09f2a8a4aa31877554f8265e887f5b6fba26144669ece551c55d994e401c27f3d2677ab939d3412734e75e412c4d1e9c1867737876144101eebbc493375be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5f8115eb0d62ce026686cfee4511fb111c763d52a1bacd31a6d80aa3a095a197174e4802ebb5a63a5df9498a88785691ee15ef8af06ff8d498fb4b4b318c883"} 00:02:23 INFO - Running post-run listener: copy_logs_to_upload_dir 00:02:23 INFO - Copying logs to upload dir... 00:02:23 INFO - mkdir: /builds/slave/test/build/upload/logs 00:02:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.992655 ========= master_lag: 282.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 25 mins, 38 secs) (at 2016-06-09 00:07:05.229907) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.234347) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee72654fd5c73eaf63951f355c7a12ec29d2613fd7745b6d81fdaf0faa31942a1e5eeca73403737c6fd11b4be1909e506209a45d8429f753434f16327f364fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5d09f2a8a4aa31877554f8265e887f5b6fba26144669ece551c55d994e401c27f3d2677ab939d3412734e75e412c4d1e9c1867737876144101eebbc493375be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5f8115eb0d62ce026686cfee4511fb111c763d52a1bacd31a6d80aa3a095a197174e4802ebb5a63a5df9498a88785691ee15ef8af06ff8d498fb4b4b318c883"} 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.011300 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fee72654fd5c73eaf63951f355c7a12ec29d2613fd7745b6d81fdaf0faa31942a1e5eeca73403737c6fd11b4be1909e506209a45d8429f753434f16327f364fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e5d09f2a8a4aa31877554f8265e887f5b6fba26144669ece551c55d994e401c27f3d2677ab939d3412734e75e412c4d1e9c1867737876144101eebbc493375be", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a5f8115eb0d62ce026686cfee4511fb111c763d52a1bacd31a6d80aa3a095a197174e4802ebb5a63a5df9498a88785691ee15ef8af06ff8d498fb4b4b318c883"}' ========= master_lag: 0.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.548298) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.548675) ========= 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=337fe3f4b1febe37b85fccc40000019e-1465452396.294654-65594468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.33 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 00:07:05.878473) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 00:07:05.878871) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 00:07:05.915771) ========= ========= Total master_lag: 283.16 =========