builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1465471162.8 results: success (0) buildid: 20160609031429 builduid: b5751525f9db4a9691c06a1f769c8809 revision: ac4dd317658c8f838e5a5975baf09e739b415ba3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.804709) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.805156) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.805539) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.820592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.820923) ========= 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=523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-09 04:19:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-09 04:19:23 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127305 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.963906) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.964252) ========= 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=523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020009 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.021381) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.021734) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ac4dd317658c8f838e5a5975baf09e739b415ba3 --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 ac4dd317658c8f838e5a5975baf09e739b415ba3 --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=523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 04:19:23,769 truncating revision to first 12 chars 2016-06-09 04:19:23,769 Setting DEBUG logging. 2016-06-09 04:19:23,769 attempt 1/10 2016-06-09 04:19:23,770 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ac4dd317658c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-09 04:19:24,163 unpacking tar archive at: fx-team-ac4dd317658c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.721456 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.758229) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.758625) ========= script_repo_revision: ac4dd317658c8f838e5a5975baf09e739b415ba3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.759052) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.759319) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.786070) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-09 04:19:23.786447) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:24 INFO - MultiFileLogger online at 20160609 04:19:24 in /builds/slave/test 04:19:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 04:19:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:24 INFO - {'append_to_log': False, 04:19:24 INFO - 'base_work_dir': '/builds/slave/test', 04:19:24 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 04:19:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:24 INFO - 'branch': 'Fx-Team-Non-PGO', 04:19:24 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:24 INFO - 'config_files': ('talos/linux_config.py',), 04:19:24 INFO - 'default_actions': ('clobber', 04:19:24 INFO - 'read-buildbot-config', 04:19:24 INFO - 'download-and-extract', 04:19:24 INFO - 'populate-webroot', 04:19:24 INFO - 'create-virtualenv', 04:19:24 INFO - 'install', 04:19:24 INFO - 'run-tests'), 04:19:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:24 INFO - 'download_minidump_stackwalk': True, 04:19:24 INFO - 'download_symbols': 'ondemand', 04:19:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:24 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:24 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:24 INFO - 'installer_path': 'installer.exe', 04:19:24 INFO - 'log_level': 'info', 04:19:24 INFO - 'log_name': 'talos', 04:19:24 INFO - 'log_to_console': True, 04:19:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:24 INFO - 'opt_config_files': (), 04:19:24 INFO - 'pip_index': False, 04:19:24 INFO - 'sps_profile': False, 04:19:24 INFO - 'sps_profile_interval': 0, 04:19:24 INFO - 'suite': 'dromaeojs', 04:19:24 INFO - 'system_bits': '32', 04:19:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:24 INFO - 'title': 'talos-linux64-ix-065', 04:19:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:24 INFO - 'use_talos_json': True, 04:19:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:24 INFO - 'work_dir': 'build'} 04:19:24 INFO - ##### 04:19:24 INFO - ##### Running clobber step. 04:19:24 INFO - ##### 04:19:24 INFO - Running pre-action listener: _resource_record_pre_action 04:19:24 INFO - Running main action method: clobber 04:19:24 INFO - rmtree: /builds/slave/test/build 04:19:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:25 INFO - Running post-action listener: _resource_record_post_action 04:19:25 INFO - ##### 04:19:25 INFO - ##### Finished clobber step (success) 04:19:25 INFO - ##### 04:19:25 INFO - ##### 04:19:25 INFO - ##### Running read-buildbot-config step. 04:19:25 INFO - ##### 04:19:25 INFO - Running pre-action listener: _resource_record_pre_action 04:19:25 INFO - Running main action method: read_buildbot_config 04:19:25 INFO - Using buildbot properties: 04:19:25 INFO - { 04:19:25 INFO - "project": "", 04:19:25 INFO - "product": "firefox", 04:19:25 INFO - "script_repo_revision": "production", 04:19:25 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:19:25 INFO - "repository": "", 04:19:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 04:19:25 INFO - "buildid": "20160609031429", 04:19:25 INFO - "pgo_build": "False", 04:19:25 INFO - "basedir": "/builds/slave/test", 04:19:25 INFO - "buildnumber": 3073, 04:19:25 INFO - "slavename": "talos-linux64-ix-065", 04:19:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:19:25 INFO - "platform": "ubuntu64_hw", 04:19:25 INFO - "scheduler": "tests-fx-team-linux64-talos", 04:19:25 INFO - "branch": "fx-team", 04:19:25 INFO - "repo_path": "integration/fx-team", 04:19:25 INFO - "revision": "ac4dd317658c8f838e5a5975baf09e739b415ba3", 04:19:25 INFO - "stage_platform": "linux64", 04:19:25 INFO - "builduid": "b5751525f9db4a9691c06a1f769c8809", 04:19:25 INFO - "slavebuilddir": "test" 04:19:25 INFO - } 04:19:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:19:25 INFO - Running post-action listener: _resource_record_post_action 04:19:25 INFO - ##### 04:19:25 INFO - ##### Finished read-buildbot-config step (success) 04:19:25 INFO - ##### 04:19:25 INFO - ##### 04:19:25 INFO - ##### Running download-and-extract step. 04:19:25 INFO - ##### 04:19:25 INFO - Running pre-action listener: _resource_record_pre_action 04:19:25 INFO - Running main action method: download_and_extract 04:19:25 INFO - mkdir: /builds/slave/test/build/tests 04:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:25 INFO - https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:19:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:28 INFO - Downloaded 1361 bytes. 04:19:28 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:28 INFO - Using the following test package requirements: 04:19:28 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:28 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:28 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:19:28 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'jsshell-linux-x86_64.zip'], 04:19:28 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:28 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:28 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:28 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:28 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:28 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:28 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:28 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:28 INFO - https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:34 INFO - Downloaded 22879579 bytes. 04:19:34 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'] 04:19:34 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 04:19:35 INFO - Return code: 0 04:19:35 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 04:19:35 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')]} 04:19:35 INFO - https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:19:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:19:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:41 INFO - Downloaded 22879579 bytes. 04:19:41 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'] 04:19:41 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 04:19:43 INFO - Return code: 0 04:19:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:43 INFO - https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:19:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:19:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:44 INFO - Downloaded 10833377 bytes. 04:19:44 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'] 04:19:44 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 04:19:44 INFO - Return code: 0 04:19:44 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')]} 04:19:44 INFO - https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:19:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/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 04:19:46 INFO - Downloaded 55434056 bytes. 04:19:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:46 INFO - mkdir: /builds/slave/test/properties 04:19:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:46 INFO - Contents: 04:19:46 INFO - build_url:https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:19:47 INFO - Running post-action listener: _resource_record_post_action 04:19:47 INFO - Running post-action listener: set_extra_try_arguments 04:19:47 INFO - ##### 04:19:47 INFO - ##### Finished download-and-extract step (success) 04:19:47 INFO - ##### 04:19:47 INFO - ##### 04:19:47 INFO - ##### Running populate-webroot step. 04:19:47 INFO - ##### 04:19:47 INFO - Running pre-action listener: _resource_record_pre_action 04:19:47 INFO - Running main action method: populate_webroot 04:19:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:47 INFO - '--tppagecycles', 04:19:47 INFO - '7'], 04:19:47 INFO - 'tests': ['tsvgm']}}, 04:19:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:19:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['damp', 'tps']}, 04:19:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'tests': ['damp', 'tps']}, 04:19:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['dromaeo_dom']}, 04:19:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['a11yr', 04:19:47 INFO - 'ts_paint', 04:19:47 INFO - 'tpaint', 04:19:47 INFO - 'sessionrestore', 04:19:47 INFO - 'sessionrestore_no_auto_restore', 04:19:47 INFO - 'tabpaint']}, 04:19:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:47 INFO - 'ts_paint', 04:19:47 INFO - 'tpaint', 04:19:47 INFO - 'sessionrestore', 04:19:47 INFO - 'sessionrestore_no_auto_restore', 04:19:47 INFO - 'tabpaint']}, 04:19:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:19:47 INFO - 'ts_paint', 04:19:47 INFO - 'tpaint', 04:19:47 INFO - 'sessionrestore', 04:19:47 INFO - 'sessionrestore_no_auto_restore', 04:19:47 INFO - 'tabpaint']}, 04:19:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:19:47 INFO - 'ts_paint', 04:19:47 INFO - 'tpaint', 04:19:47 INFO - 'sessionrestore', 04:19:47 INFO - 'sessionrestore_no_auto_restore', 04:19:47 INFO - 'tabpaint']}, 04:19:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['a11yr', 04:19:47 INFO - 'ts_paint', 04:19:47 INFO - 'tpaint', 04:19:47 INFO - 'sessionrestore', 04:19:47 INFO - 'sessionrestore_no_auto_restore', 04:19:47 INFO - 'tabpaint']}, 04:19:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['a11yr', 04:19:47 INFO - 'ts_paint', 04:19:47 INFO - 'tpaint', 04:19:47 INFO - 'sessionrestore', 04:19:47 INFO - 'sessionrestore_no_auto_restore', 04:19:47 INFO - 'tabpaint']}, 04:19:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['tsvgx', 04:19:47 INFO - 'tsvgr_opacity', 04:19:47 INFO - 'tart', 04:19:47 INFO - 'tscrollx', 04:19:47 INFO - 'cart']}, 04:19:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:47 INFO - 'tsvgr_opacity', 04:19:47 INFO - 'tart', 04:19:47 INFO - 'tscrollx', 04:19:47 INFO - 'cart']}, 04:19:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'talos_options': ['--disable-e10s'], 04:19:47 INFO - 'tests': ['tp5o']}, 04:19:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'tests': ['tp5o']}, 04:19:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'talos_options': ['--disable-e10s', 04:19:47 INFO - '--xperf_path', 04:19:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:47 INFO - 'tests': ['tp5n']}, 04:19:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:47 INFO - 'talos_options': ['--xperf_path', 04:19:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:47 INFO - 'tests': ['tp5n']}}, 04:19:47 INFO - 'talos.zip': {'path': '', 04:19:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:47 INFO - Running post-action listener: _resource_record_post_action 04:19:47 INFO - ##### 04:19:47 INFO - ##### Finished populate-webroot step (success) 04:19:47 INFO - ##### 04:19:47 INFO - ##### 04:19:47 INFO - ##### Running create-virtualenv step. 04:19:47 INFO - ##### 04:19:47 INFO - Running pre-action listener: _resource_record_pre_action 04:19:47 INFO - Running main action method: create_virtualenv 04:19:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:47 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 04:19:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:47 INFO - Using real prefix '/usr' 04:19:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:47 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:49 INFO - Installing pip.................done. 04:19:49 INFO - Return code: 0 04:19:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:49 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:19:49 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 04:19:49 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 04:19:49 INFO - Using env: {'DISPLAY': ':0', 04:19:49 INFO - 'HOME': '/home/cltbld', 04:19:49 INFO - 'LANG': 'en_US.UTF-8', 04:19:49 INFO - 'LANGUAGE': 'en_US:en', 04:19:49 INFO - 'LOGNAME': 'cltbld', 04:19:49 INFO - 'MAIL': '/var/mail/cltbld', 04:19:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:49 INFO - 'MOZ_NO_REMOTE': '1', 04:19:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:49 INFO - 'NO_EM_RESTART': '1', 04:19:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:49 INFO - 'PWD': '/builds/slave/test', 04:19:49 INFO - 'SHELL': '/bin/bash', 04:19:49 INFO - 'SHLVL': '1', 04:19:49 INFO - 'TERM': 'linux', 04:19:49 INFO - 'TMOUT': '86400', 04:19:49 INFO - 'USER': 'cltbld', 04:19:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:19:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:49 INFO - '_': '/tools/buildbot/bin/python'} 04:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:50 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 04:19:50 INFO - Cleaning up... 04:19:50 INFO - Return code: 0 04:19:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:19:50 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')]} 04:19:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:50 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')]} 04:19:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:50 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:19:50 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 04:19:50 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 04:19:50 INFO - Using env: {'DISPLAY': ':0', 04:19:50 INFO - 'HOME': '/home/cltbld', 04:19:50 INFO - 'LANG': 'en_US.UTF-8', 04:19:50 INFO - 'LANGUAGE': 'en_US:en', 04:19:50 INFO - 'LOGNAME': 'cltbld', 04:19:50 INFO - 'MAIL': '/var/mail/cltbld', 04:19:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:50 INFO - 'MOZ_NO_REMOTE': '1', 04:19:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:50 INFO - 'NO_EM_RESTART': '1', 04:19:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:50 INFO - 'PWD': '/builds/slave/test', 04:19:50 INFO - 'SHELL': '/bin/bash', 04:19:50 INFO - 'SHLVL': '1', 04:19:50 INFO - 'TERM': 'linux', 04:19:50 INFO - 'TMOUT': '86400', 04:19:50 INFO - 'USER': 'cltbld', 04:19:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:19:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:50 INFO - '_': '/tools/buildbot/bin/python'} 04:19:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:50 INFO - Downloading/unpacking psutil>=3.1.1 04:19:50 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 04:19:50 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 04:19:50 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 04:19:50 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 04:19:50 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 04:19:50 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 04:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:52 INFO - Installing collected packages: psutil 04:19:52 INFO - Running setup.py install for psutil 04:19:52 INFO - building 'psutil._psutil_linux' extension 04:19:52 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 04:19:52 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 04:19:52 INFO - building 'psutil._psutil_posix' extension 04:19:52 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 04:19:52 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 04:19:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:52 INFO - Successfully installed psutil 04:19:52 INFO - Cleaning up... 04:19:52 INFO - Return code: 0 04:19:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:52 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:19:52 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 04:19:52 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 04:19:52 INFO - Using env: {'DISPLAY': ':0', 04:19:52 INFO - 'HOME': '/home/cltbld', 04:19:52 INFO - 'LANG': 'en_US.UTF-8', 04:19:52 INFO - 'LANGUAGE': 'en_US:en', 04:19:52 INFO - 'LOGNAME': 'cltbld', 04:19:52 INFO - 'MAIL': '/var/mail/cltbld', 04:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:52 INFO - 'MOZ_NO_REMOTE': '1', 04:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:52 INFO - 'NO_EM_RESTART': '1', 04:19:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:52 INFO - 'PWD': '/builds/slave/test', 04:19:52 INFO - 'SHELL': '/bin/bash', 04:19:52 INFO - 'SHLVL': '1', 04:19:52 INFO - 'TERM': 'linux', 04:19:52 INFO - 'TMOUT': '86400', 04:19:52 INFO - 'USER': 'cltbld', 04:19:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:52 INFO - '_': '/tools/buildbot/bin/python'} 04:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:19:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:19:54 INFO - Installing collected packages: mozsystemmonitor 04:19:54 INFO - Running setup.py install for mozsystemmonitor 04:19:55 INFO - Successfully installed mozsystemmonitor 04:19:55 INFO - Cleaning up... 04:19:55 INFO - Return code: 0 04:19:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19: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')]} 04:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:55 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:19:55 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 04:19:55 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 04:19:55 INFO - Using env: {'DISPLAY': ':0', 04:19:55 INFO - 'HOME': '/home/cltbld', 04:19:55 INFO - 'LANG': 'en_US.UTF-8', 04:19:55 INFO - 'LANGUAGE': 'en_US:en', 04:19:55 INFO - 'LOGNAME': 'cltbld', 04:19:55 INFO - 'MAIL': '/var/mail/cltbld', 04:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:55 INFO - 'MOZ_NO_REMOTE': '1', 04:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:55 INFO - 'NO_EM_RESTART': '1', 04:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:55 INFO - 'PWD': '/builds/slave/test', 04:19:55 INFO - 'SHELL': '/bin/bash', 04:19:55 INFO - 'SHLVL': '1', 04:19:55 INFO - 'TERM': 'linux', 04:19:55 INFO - 'TMOUT': '86400', 04:19:55 INFO - 'USER': 'cltbld', 04:19:55 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:55 INFO - '_': '/tools/buildbot/bin/python'} 04:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:55 INFO - Downloading/unpacking jsonschema==2.5.1 04:19:55 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 04:19:55 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 04:19:55 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 04:19:55 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 04:19:55 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 04:19:55 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 04:19:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:57 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:57 INFO - warning: no files found matching '*.txt' 04:19:57 INFO - no previously-included directories found matching 'build' 04:19:57 INFO - no previously-included directories found matching 'dist' 04:19:57 INFO - no previously-included directories found matching '.git*' 04:19:57 INFO - Installing collected packages: jsonschema, functools32 04:19:57 INFO - Running setup.py install for functools32 04:19:57 INFO - warning: no files found matching '*.txt' 04:19:57 INFO - no previously-included directories found matching 'build' 04:19:57 INFO - no previously-included directories found matching 'dist' 04:19:57 INFO - no previously-included directories found matching '.git*' 04:19:57 INFO - Successfully installed jsonschema functools32 04:19:57 INFO - Cleaning up... 04:19:57 INFO - Return code: 0 04:19:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:19:57 INFO - Using env: {'DISPLAY': ':0', 04:19:57 INFO - 'HOME': '/home/cltbld', 04:19:57 INFO - 'LANG': 'en_US.UTF-8', 04:19:57 INFO - 'LANGUAGE': 'en_US:en', 04:19:57 INFO - 'LOGNAME': 'cltbld', 04:19:57 INFO - 'MAIL': '/var/mail/cltbld', 04:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:57 INFO - 'MOZ_NO_REMOTE': '1', 04:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:57 INFO - 'NO_EM_RESTART': '1', 04:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:57 INFO - 'PWD': '/builds/slave/test', 04:19:57 INFO - 'SHELL': '/bin/bash', 04:19:57 INFO - 'SHLVL': '1', 04:19:57 INFO - 'TERM': 'linux', 04:19:57 INFO - 'TMOUT': '86400', 04:19:57 INFO - 'USER': 'cltbld', 04:19:57 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:57 INFO - '_': '/tools/buildbot/bin/python'} 04:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:57 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:59 INFO - Downloading blobuploader-1.2.4.tar.gz 04:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:19:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:00 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 04:20:00 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 04:20:00 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 04:20:00 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 04:20:00 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 04:20:00 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 04:20:00 INFO - Downloading docopt-0.6.1.tar.gz 04:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:00 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:00 INFO - Running setup.py install for blobuploader 04:20:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:00 INFO - Running setup.py install for requests 04:20:01 INFO - Running setup.py install for docopt 04:20:01 INFO - Successfully installed blobuploader requests docopt 04:20:01 INFO - Cleaning up... 04:20:01 INFO - Return code: 0 04:20:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:01 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:20:01 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 04:20:01 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 04:20:01 INFO - Using env: {'DISPLAY': ':0', 04:20:01 INFO - 'HOME': '/home/cltbld', 04:20:01 INFO - 'LANG': 'en_US.UTF-8', 04:20:01 INFO - 'LANGUAGE': 'en_US:en', 04:20:01 INFO - 'LOGNAME': 'cltbld', 04:20:01 INFO - 'MAIL': '/var/mail/cltbld', 04:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:01 INFO - 'MOZ_NO_REMOTE': '1', 04:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:01 INFO - 'NO_EM_RESTART': '1', 04:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:01 INFO - 'PWD': '/builds/slave/test', 04:20:01 INFO - 'SHELL': '/bin/bash', 04:20:01 INFO - 'SHLVL': '1', 04:20:01 INFO - 'TERM': 'linux', 04:20:01 INFO - 'TMOUT': '86400', 04:20:01 INFO - 'USER': 'cltbld', 04:20:01 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:01 INFO - '_': '/tools/buildbot/bin/python'} 04:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:01 INFO - Running setup.py (path:/tmp/pip-qi68Xh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:01 INFO - Running setup.py (path:/tmp/pip-EJOtoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:01 INFO - Running setup.py (path:/tmp/pip-0B71Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:01 INFO - Running setup.py (path:/tmp/pip-GKjJnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:01 INFO - Running setup.py (path:/tmp/pip-X0KnLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:01 INFO - Running setup.py (path:/tmp/pip-aYSilL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:01 INFO - Running setup.py (path:/tmp/pip-HycQ1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:01 INFO - Running setup.py (path:/tmp/pip-mbPJXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:01 INFO - Running setup.py (path:/tmp/pip-MbrxTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:02 INFO - Running setup.py (path:/tmp/pip-YLD9AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:02 INFO - Running setup.py (path:/tmp/pip-yXhpdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:02 INFO - Running setup.py (path:/tmp/pip-EQfzKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:02 INFO - Running setup.py (path:/tmp/pip-Y4LdFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:02 INFO - Running setup.py (path:/tmp/pip-M5fNTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:02 INFO - Running setup.py (path:/tmp/pip-gJ7dVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:02 INFO - Running setup.py (path:/tmp/pip-s7ElKo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:02 INFO - Running setup.py (path:/tmp/pip-gPXWlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:02 INFO - Running setup.py install for manifestparser 04:20:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:02 INFO - Running setup.py install for mozcrash 04:20:02 INFO - Running setup.py install for mozdebug 04:20:02 INFO - Running setup.py install for mozdevice 04:20:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozfile 04:20:03 INFO - Running setup.py install for mozhttpd 04:20:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozinfo 04:20:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozInstall 04:20:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozleak 04:20:03 INFO - Running setup.py install for mozlog 04:20:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for moznetwork 04:20:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Running setup.py install for mozprocess 04:20:03 INFO - Running setup.py install for mozprofile 04:20:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozrunner 04:20:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Running setup.py install for mozscreenshot 04:20:04 INFO - Running setup.py install for moztest 04:20:04 INFO - Running setup.py install for mozversion 04:20:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:04 INFO - Cleaning up... 04:20:04 INFO - Return code: 0 04:20:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:04 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')]} 04:20:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:04 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')]} 04:20:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:04 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:20:04 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 04:20:04 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 04:20:04 INFO - Using env: {'DISPLAY': ':0', 04:20:04 INFO - 'HOME': '/home/cltbld', 04:20:04 INFO - 'LANG': 'en_US.UTF-8', 04:20:04 INFO - 'LANGUAGE': 'en_US:en', 04:20:04 INFO - 'LOGNAME': 'cltbld', 04:20:04 INFO - 'MAIL': '/var/mail/cltbld', 04:20:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:04 INFO - 'MOZ_NO_REMOTE': '1', 04:20:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:04 INFO - 'NO_EM_RESTART': '1', 04:20:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:04 INFO - 'PWD': '/builds/slave/test', 04:20:04 INFO - 'SHELL': '/bin/bash', 04:20:04 INFO - 'SHLVL': '1', 04:20:04 INFO - 'TERM': 'linux', 04:20:04 INFO - 'TMOUT': '86400', 04:20:04 INFO - 'USER': 'cltbld', 04:20:04 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:20:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:04 INFO - '_': '/tools/buildbot/bin/python'} 04:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:04 INFO - Running setup.py (path:/tmp/pip-cXQpel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:04 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)) 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:04 INFO - Running setup.py (path:/tmp/pip-5gz7kD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:04 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)) 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:04 INFO - Running setup.py (path:/tmp/pip-c4Z47P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:04 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)) 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:04 INFO - Running setup.py (path:/tmp/pip-Fn7vOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:04 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)) 04:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:04 INFO - Running setup.py (path:/tmp/pip-AAHiDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:05 INFO - Running setup.py (path:/tmp/pip-MQJi6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:05 INFO - Running setup.py (path:/tmp/pip-JSlGdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:05 INFO - Running setup.py (path:/tmp/pip-kGP_u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:05 INFO - Running setup.py (path:/tmp/pip-dPgMjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:05 INFO - Running setup.py (path:/tmp/pip-i0s53T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:05 INFO - Running setup.py (path:/tmp/pip-i9CrmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:05 INFO - Running setup.py (path:/tmp/pip-HPBo9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:05 INFO - Running setup.py (path:/tmp/pip-0GKMzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:05 INFO - Running setup.py (path:/tmp/pip-4XB0XE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:05 INFO - Running setup.py (path:/tmp/pip-lKZFWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:05 INFO - Running setup.py (path:/tmp/pip-zVefyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:05 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)) 04:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:05 INFO - Running setup.py (path:/tmp/pip-a8lD2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:05 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)) 04:20:05 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)) 04:20:05 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)) 04:20:05 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)) 04:20:05 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)) 04:20:05 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)) 04:20:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:07 INFO - Downloading blessings-1.6.tar.gz 04:20:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:07 INFO - Installing collected packages: blessings 04:20:07 INFO - Running setup.py install for blessings 04:20:08 INFO - Successfully installed blessings 04:20:08 INFO - Cleaning up... 04:20:08 INFO - Return code: 0 04:20:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:08 INFO - Reading from file tmpfile_stdout 04:20:08 INFO - Current package versions: 04:20:08 INFO - argparse == 1.2.1 04:20:08 INFO - blessings == 1.6 04:20:08 INFO - blobuploader == 1.2.4 04:20:08 INFO - docopt == 0.6.1 04:20:08 INFO - functools32 == 3.2.3-2 04:20:08 INFO - jsonschema == 2.5.1 04:20:08 INFO - manifestparser == 1.1 04:20:08 INFO - mozInstall == 1.12 04:20:08 INFO - mozcrash == 0.17 04:20:08 INFO - mozdebug == 0.1 04:20:08 INFO - mozdevice == 0.48 04:20:08 INFO - mozfile == 1.2 04:20:08 INFO - mozhttpd == 0.7 04:20:08 INFO - mozinfo == 0.9 04:20:08 INFO - mozleak == 0.1 04:20:08 INFO - mozlog == 3.2 04:20:08 INFO - moznetwork == 0.27 04:20:08 INFO - mozprocess == 0.22 04:20:08 INFO - mozprofile == 0.28 04:20:08 INFO - mozrunner == 6.11 04:20:08 INFO - mozscreenshot == 0.1 04:20:08 INFO - mozsystemmonitor == 0.3 04:20:08 INFO - moztest == 0.7 04:20:08 INFO - mozversion == 1.4 04:20:08 INFO - psutil == 3.1.1 04:20:08 INFO - requests == 1.2.3 04:20:08 INFO - wsgiref == 0.1.2 04:20:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:08 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 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:20:08 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 04:20:08 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 04:20:08 INFO - Using env: {'DISPLAY': ':0', 04:20:08 INFO - 'HOME': '/home/cltbld', 04:20:08 INFO - 'LANG': 'en_US.UTF-8', 04:20:08 INFO - 'LANGUAGE': 'en_US:en', 04:20:08 INFO - 'LOGNAME': 'cltbld', 04:20:08 INFO - 'MAIL': '/var/mail/cltbld', 04:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:08 INFO - 'MOZ_NO_REMOTE': '1', 04:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:08 INFO - 'NO_EM_RESTART': '1', 04:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:08 INFO - 'PWD': '/builds/slave/test', 04:20:08 INFO - 'SHELL': '/bin/bash', 04:20:08 INFO - 'SHLVL': '1', 04:20:08 INFO - 'TERM': 'linux', 04:20:08 INFO - 'TMOUT': '86400', 04:20:08 INFO - 'USER': 'cltbld', 04:20:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:08 INFO - '_': '/tools/buildbot/bin/python'} 04:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 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)) 04:20:08 INFO - Cleaning up... 04:20:08 INFO - Return code: 0 04:20:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:20: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', 'jsonschema'] in /builds/slave/test/build 04:20: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 jsonschema 04:20:08 INFO - Using env: {'DISPLAY': ':0', 04:20:08 INFO - 'HOME': '/home/cltbld', 04:20:08 INFO - 'LANG': 'en_US.UTF-8', 04:20:08 INFO - 'LANGUAGE': 'en_US:en', 04:20:08 INFO - 'LOGNAME': 'cltbld', 04:20:08 INFO - 'MAIL': '/var/mail/cltbld', 04:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:08 INFO - 'MOZ_NO_REMOTE': '1', 04:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:08 INFO - 'NO_EM_RESTART': '1', 04:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:08 INFO - 'PWD': '/builds/slave/test', 04:20:08 INFO - 'SHELL': '/bin/bash', 04:20:08 INFO - 'SHLVL': '1', 04:20:08 INFO - 'TERM': 'linux', 04:20:08 INFO - 'TMOUT': '86400', 04:20:08 INFO - 'USER': 'cltbld', 04:20:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:08 INFO - '_': '/tools/buildbot/bin/python'} 04:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:08 INFO - Cleaning up... 04:20:08 INFO - Return code: 0 04:20:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:20: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')]} 04:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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')]} 04:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f241da4cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100e350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, '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': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', '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 04:20: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', 'flake8'] in /builds/slave/test/build 04:20: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 flake8 04:20:08 INFO - Using env: {'DISPLAY': ':0', 04:20:08 INFO - 'HOME': '/home/cltbld', 04:20:08 INFO - 'LANG': 'en_US.UTF-8', 04:20:08 INFO - 'LANGUAGE': 'en_US:en', 04:20:08 INFO - 'LOGNAME': 'cltbld', 04:20:08 INFO - 'MAIL': '/var/mail/cltbld', 04:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:08 INFO - 'MOZ_NO_REMOTE': '1', 04:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:08 INFO - 'NO_EM_RESTART': '1', 04:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:08 INFO - 'PWD': '/builds/slave/test', 04:20:08 INFO - 'SHELL': '/bin/bash', 04:20:08 INFO - 'SHLVL': '1', 04:20:08 INFO - 'TERM': 'linux', 04:20:08 INFO - 'TMOUT': '86400', 04:20:08 INFO - 'USER': 'cltbld', 04:20:08 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:08 INFO - '_': '/tools/buildbot/bin/python'} 04:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:08 INFO - Downloading/unpacking flake8 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:20:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:20:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20: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 04:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:11 INFO - no previously-included directories found matching 'docs/_build' 04:20:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:20:11 INFO - Running setup.py install for pep8 04:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:11 INFO - no previously-included directories found matching 'docs/_build' 04:20:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:20:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:20:11 INFO - Cleaning up... 04:20:11 INFO - Return code: 0 04:20:11 INFO - Running post-action listener: _resource_record_post_action 04:20:11 INFO - Running post-action listener: _start_resource_monitoring 04:20:11 INFO - Starting resource monitoring. 04:20:11 INFO - ##### 04:20:11 INFO - ##### Finished create-virtualenv step (success) 04:20:11 INFO - ##### 04:20:11 INFO - ##### 04:20:11 INFO - ##### Running install step. 04:20:11 INFO - ##### 04:20:11 INFO - Running pre-action listener: _resource_record_pre_action 04:20:11 INFO - Running main action method: install 04:20:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:12 INFO - Reading from file tmpfile_stdout 04:20:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:12 INFO - Reading from file tmpfile_stdout 04:20:12 INFO - Output received: 04:20:12 INFO - Usage: mozinstall [options] installer 04:20:12 INFO - Options: 04:20:12 INFO - -h, --help show this help message and exit 04:20:12 INFO - -d DEST, --destination=DEST 04:20:12 INFO - Directory to install application into. [default: 04:20:12 INFO - "/builds/slave/test"] 04:20:12 INFO - --app=APP Application being installed. [default: firefox] 04:20:12 INFO - mkdir: /builds/slave/test/build/application 04:20:12 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'] 04:20:12 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 04:20:28 INFO - Reading from file tmpfile_stdout 04:20:28 INFO - Output received: 04:20:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:28 INFO - Running post-action listener: _resource_record_post_action 04:20:28 INFO - ##### 04:20:28 INFO - ##### Finished install step (success) 04:20:28 INFO - ##### 04:20:28 INFO - ##### 04:20:28 INFO - ##### Running run-tests step. 04:20:28 INFO - ##### 04:20:28 INFO - Running pre-action listener: _resource_record_pre_action 04:20:28 INFO - Running main action method: run_tests 04:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:28 INFO - Python 2.7.3 04:20:28 INFO - Return code: 0 04:20:28 INFO - grabbing minidump binary from tooltool 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:28 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 0x109d1c0>, '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 0x109e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:28 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 04:20:28 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 04:20:28 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 04:20:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:28 INFO - Return code: 0 04:20:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:29 INFO - Return code: 0 04:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:20:29 INFO - Using env: {'DISPLAY': ':0', 04:20:29 INFO - 'HOME': '/home/cltbld', 04:20:29 INFO - 'LANG': 'en_US.UTF-8', 04:20:29 INFO - 'LANGUAGE': 'en_US:en', 04:20:29 INFO - 'LOGNAME': 'cltbld', 04:20:29 INFO - 'MAIL': '/var/mail/cltbld', 04:20:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:29 INFO - 'MOZ_NO_REMOTE': '1', 04:20:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:29 INFO - 'NO_EM_RESTART': '1', 04:20:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:29 INFO - 'PWD': '/builds/slave/test', 04:20:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:29 INFO - 'SHELL': '/bin/bash', 04:20:29 INFO - 'SHLVL': '1', 04:20:29 INFO - 'TERM': 'linux', 04:20:29 INFO - 'TMOUT': '86400', 04:20:29 INFO - 'USER': 'cltbld', 04:20:29 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808', 04:20:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:29 INFO - '_': '/tools/buildbot/bin/python'} 04:20:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:20:29 INFO - mozversion application_buildid: 20160609031429 04:20:29 INFO - mozversion application_changeset: ac4dd317658c8f838e5a5975baf09e739b415ba3 04:20:29 INFO - mozversion application_display_name: Nightly 04:20:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:29 INFO - mozversion application_name: Firefox 04:20:29 INFO - mozversion application_remotingname: firefox 04:20:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:20:29 INFO - mozversion application_vendor: Mozilla 04:20:29 INFO - mozversion application_version: 50.0a1 04:20:29 INFO - mozversion platform_buildid: 20160609031429 04:20:29 INFO - mozversion platform_changeset: ac4dd317658c8f838e5a5975baf09e739b415ba3 04:20:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:20:29 INFO - mozversion platform_version: 50.0a1 04:20:29 INFO - using testdate: 1465471229 04:20:29 INFO - actual date: 1465471229 04:20:29 INFO - starting webserver on 'localhost:58669' 04:20:29 INFO - SUITE-START | Running 2 tests 04:20:29 INFO - TEST-START | dromaeo_css 04:20:29 INFO - operating with platform_type : linux_ 04:20:29 INFO - Initialising browser for dromaeo_css test... 04:20:29 INFO - TEST-INFO | started process 3696 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYW55v3/profile http://localhost:58669/getInfo.html) 04:20:33 INFO - PROCESS | 3696 | __metrics Screen width/height:1600/1200 04:20:33 INFO - PROCESS | 3696 | colorDepth:24 04:20:33 INFO - PROCESS | 3696 | Browser inner width/height: 1024/697 04:20:33 INFO - PROCESS | 3696 | __metrics 04:20:34 ERROR - PROCESS | 3696 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:20:35 INFO - PROCESS | 3696 | console.error: PushService: 04:20:35 INFO - PROCESS | 3696 | stateChangeProcessEnqueue: Error transitioning state 04:20:35 INFO - PROCESS | 3696 | UnknownError 04:20:35 INFO - TEST-INFO | 3696: exit 0 04:20:35 INFO - Browser initialized. 04:20:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:35 INFO - TEST-INFO | started process 3775 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYW55v3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:47 INFO - PROCESS | 3775 | RSS: Main: 175509504 04:20:47 INFO - PROCESS | 3775 | 04:21:39 INFO - PROCESS | 3775 | 1465471299506 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] 04:23:50 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:58669/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58669/tests/dromaeo/cssquery-ext.html) 04:23:51 INFO - PROCESS | 3775 | RSS: Main: 252600320 04:23:51 INFO - PROCESS | 3775 | 04:26:54 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:58669/tests/dromaeo/cssquery-ext.html (next: http://localhost:58669/tests/dromaeo/cssquery-jquery.html) 04:26:55 INFO - PROCESS | 3775 | RSS: Main: 259637248 04:26:55 INFO - PROCESS | 3775 | 04:29:57 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:58669/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58669/tests/dromaeo/cssquery-mootools.html) 04:29:57 INFO - PROCESS | 3775 | RSS: Main: 262590464 04:29:57 INFO - PROCESS | 3775 | 04:33:00 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:58669/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58669/tests/dromaeo/cssquery-prototype.html) 04:33:00 INFO - PROCESS | 3775 | RSS: Main: 259497984 04:33:00 INFO - PROCESS | 3775 | 04:36:03 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:58669/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58669/tests/dromaeo/cssquery-yui.html) 04:36:04 INFO - PROCESS | 3775 | RSS: Main: 243699712 04:36:04 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | Cycle 1(1): loaded http://localhost:58669/tests/dromaeo/cssquery-yui.html (next: http://localhost:58669/tests/dromaeo/cssquery-dojo.html) 04:39:07 INFO - PROCESS | 3775 | RSS: Main: 314937344 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | __start_tp_report 04:39:07 INFO - PROCESS | 3775 | _x_x_mozilla_page_load 04:39:07 INFO - PROCESS | 3775 | _x_x_mozilla_page_load_details 04:39:07 INFO - PROCESS | 3775 | |i|pagename|runs| 04:39:07 INFO - PROCESS | 3775 | |0;dojo.html;2523.911663091792;2575.562154433746;2594.390318275205;2619.3582572269797;2624.2389706984977;4534.251848445011;4586.38083858679;4687.226607609745;4709.128811169936;4731.958969026813;4647.744374059425;4686.133065382906;4687.578117969382;4704.670673052888;4709.717416954985;4136.627703506684;4276.358546218061;4369.213541562517;4399.406080179183;4495.190865644183;4379.948812285044;4418.160549495586;4428.158649856517;4439.600435960763;4467.10657868426;4144.254034273845;4193.853215137486;4261.21167583998;4302.5052119006405;4307.82768689252;4258.446401967755;4265.55211702773;4267.061246525759;4311.2670845955945;4329.675274354436;4280.5719428057255;4296.8710938671575;4303.31147016479;4340.153670034345;4348.434703488558;4513.480949690795;4583.931241031387;4651.581357677791;4663.953360466419;4707.270373092176;4984.725840078794;5032.597392208614;5040.873978150539;5042.470540593222;5046.823361182341;5001.224810154432;5063.493650634907;5065.1642478990925;5070.3915530136255;5070.670406423571;4510.616597589209;4629.213033784265;4674.626029917598;4681.765911704401;4687.789049492781;5164.870878227999;5168.508991645787;5172.8965420691375;5186.4035635902355;5191.896162076738;4714.95285047152;4926.113299606033;4926.827561035347;4964.925526117111;4970.254461830682;4929.704217746875;4978.178600530872;4978.253262010655;4980.825671101494;5001.599872010231;4939.604831613462;4952.405711314594;4955.231939049453;4960.107180707508;5006.1739812930455;4780.426348838092;4822.590079843182;4949.059678661043;4957.752112394366;5006.299118123466;4236.364545318165;4244.511881133647;4261.829526818955;4293;4302.376155457441;3676.191237927652;3685.9262814743556;3695.8336874840697;3710.7402481826553;3714.832832522543;4178.958210417918;4233.661307095486;4263.616274535307;4265.914681706348;4308.052228509723;4959.479254678279;5021.246812978083;5026.899462010812;5036.143855544567;5038.445770965191;4309.288967320357;4327.805248763813;4329.437173167531;4371.737695738202;4378.474583050054;4396.714213576107;4534.047849951481;4550.97724511382;4551.5676010778925;4552.795124219352;4726.787294571684;4730.52694730531;4758.072175925661;4762.571368576845;4799.66402351839;5031.899362012666;5033.169527028;5039.546440820343;5075.416327122428;5079.796808127781;4570.131674981742;4654.883627909329;4671.299305104126;4755.500672429345;4798.352222450064;4926.926096108633;4941.456439791692;4944.5302696245235;4945.357103576512;4989.276554899447;4992.900141997067;5008.424031236309;5021.246812977936;5031.6729412588065;5054.595632349477;4729.527047295243;4802.135615589088;4853.757312134449;4859.95140048595;4927;4821.927671085006;4848.75756212195;4857.319975203403;4860.878478038077;4906.092372911023;4781.665283430266;4791.544803243686;4794.448638406628;4843.660943733905;4844.636652251025;4751.40607424072;4825;4864.100141473838;4878.707277563358;4886.609071274218;4758.04839032188;4766.642501812308;4771.332013518179;4789.784459699252;4823.469418363907 04:39:07 INFO - PROCESS | 3775 | |1;ext.html;553.5073784331944;568.2385603291589;573.9971300143496;578.5892016668165;581.3605034462092;27411.177664670067;27928.720712792892;30157.69842301579;38436.23127537448;39765.40351894724;42362.364564531556;42877.35683964743;42888;42888.57111428893;42926.57073429273;7925.643346049427;8088.595570221495;8090.959545202266;8091.919080809175;8092.635831387602;7875.4487185897015;7956.045274567031;7969.163237860028;7970.083440404341;7971.800704982393;7961.96019019907;7992.080910695257;7995.800104997364;8000.119986801447;8001.8799718004275;7898.565578893159;7941.523508589503;7947.403944704141;7956.641951112156;7958.960205198937;7933.246341597539;7950.403719721044;7952.165022672594;7993.080795708452;7999.240072193191;39922;40228.39657405141;40252.79873600643;40375.59624403777;40434;3201.3117179806454;3248.2366643838677;3264.9927970769754;3429.8971030869116;3731.5522137343423;30165;30548.69451305481;30700.692993070006;30944.845275773478;31823;3518.841652125635;3565.9108522286892;3572.6427357264065;3631.1466805300734;3642.3990041643096;254585.99999999814;255228;256022;256037;256988;32405.18987025296;33374.666253337644;33439.66560334365;53731.19403208955;54322.45677543253;34628.30743385118;34706;34773.130671732906;34788.478172827425;34835.825820870734;13321.733565328834;13446.731065378637;13448.058635895393;13448.260345680887;13451.26018068996;11172.776544469227;11264.43677816106;11270.943645281885;11272.098232141409;11274.774504510027;7727.343175830118;7734.955780969497;7786.844263114706;7796.883046754303;7837.921620783719;3067.4478593852873;3109.144985129062;3127.8436078196;3151.7163455289133;3167.857446414917;829.2288172000098;853.47511280562;910.8129204182119;931.993447077155;1005.8994100590029;27940.44119117606;28013.879444822385;28094.87620495157;28451.430971380458;28466;902.697596305232;937.0676177203726;939.7650587353162;987.4963768478128;1071.1430855315716;14602.34289456977;14997.475088371855;15033.323500442506;15301.693966120616;15357.848161387717;388663;391417;392829;393235;393440;51092.489075109515;51593.74203128961;51755.48244517582;51764.74117629388;51786.48213517892;1067.6583493282076;1137.6814491942268;1172.0447835014606;1195.5875223048035;1204.9036077113985;28727.856360718062;29108.7089129106;29411.55882661719;29840.10479685613;29998.4000319988;43472.78263608662;43820.78089609532;43827.56172438235;43907;43972.780136099114;297498;297695;299882;299925;300363;22414.551708965402;24983.250502484956;25845.22464326073;26113.73886261189;26145.869270653526;42936.57063429326;43080.138397232506;43272.35091473693;43931.34102988522;44236.11527769491;35928;36982.59613125138;37455;37652.246955061295;37871;35165.296694066485;36826.07934801544;36855.63144368522;39045.6095439042;39873.60126398815;36978.44532331963;37004.62995370012;37099.25801483901;38075.23849523049;38160.23679526339;31588.684113159492;33268.350228940166;33541.83229083937;34048.82975585106;34258;25273;25364.873175634002;25927.611085834105;26093.527075327904;26189.34526636773 04:39:07 INFO - PROCESS | 3775 | |2;jquery.html;350.8000439749343;353.7559084231879;358.71482171673534;363.2063940290467;368.5816598161088;15607.687846243083;16331.836681633195;17048.573785655335;17084.402045928397;17093.914530427344;15681.137537435436;15989.760153597705;16248;16730.58173545662;16771.077590732504;4868.537488938545;5092.949070509303;5099.923501147486;5106.69359838409;5107.974460127694;3736.8131593420358;3902.8829135125993;4942.406911170665;5477.287952566161;5801.912971305413;5835.212246346752;5846.181534585162;5851;5877.14781356703;5881.3530511643685;5689.402612725646;5774.364819869811;5836.620619659709;5837.795677151301;5856.472917437451;3383.374075795961;4822.590079843218;5105.132127538291;5108.514691104339;5133.178691409356;20148.29480968159;20307.492312692302;20383.49041273965;20550.897245513825;20645.89677051605;1972.881627102364;2019.8385928091407;2167.2739632223224;2506.3608779761225;2515.295717199187;10562.683119506428;12253.69365765863;12768.744625107538;13149.342532873414;13558.186508809504;1571.347890625389;1642;1652.4051341517045;1700.9404670836584;1743.947681569555;63975;65334.673326633536;66657.66671166662;67028;68066.9789953156;8635.78410539729;8701.825963480822;9240.7689807754;9431;9641.746572945613;12581.433835477426;12648.936755316348;12650.620481385573;12677.683057923441;12681.35142431478;7125.857482850418;7136.678849451787;7176.390006849476;7200.423966082701;7212.206657267697;6845.828854278683;6905.067815844796;7030.354531441389;7049;7140.250273721288;5890.852728681817;5912.733926973297;5949.672767997715;6002.579819412686;6028.367021462771;1515.4241388272385;1591.283922234999;1616.4665660332062;1711.606330543957;1712.4605749188966;798.6366203377565;808.6846130009301;858.8625819868791;932.1750251027889;983.257640481432;16746.4138755143;17076.57308567271;17110.743338849927;17299.74050389245;17316.220770065378;900.2797761790541;912.3385545479474;926.9073092690677;958.4009993753904;964.2141654551518;9123.81752364949;9651.890032646195;9926.305158638826;9942.403455792675;10208.285420020677;380748;381240;398853;405518;416968;78398.21601783909;80863.19136808674;83171.58414207891;83871;84059.5797021011;945.5036106044245;957.2724729205854;958.3483231402573;977.8826540815147;984.6307634637011;15413.383464661736;15550.611234719223;15629.452969146025;15866.20668966524;16038.839611603735;33701;35043.82478087593;35442.46836297406;36240.09399765027;36857.63142368542;39564.80217598894;50023.24965125453;52146.47853521416;52546;53186.73406632942;7402.29678180572;7506.662200201114;7735.149133595188;7753.651085701044;7831.765047048598;8162.632681529227;11587.884121159017;11746.941265293619;11881.405929703653;11963.820542692041;5096.337476128079;6323.557350985387;9835.459049752333;9904.950475247577;10409.219308551737;10154.847677284699;10159.44123073238;10267.897321026694;10277.229207809294;10284.382937023802;10287.639932602324;10346.793064138525;10475;10650.467476626292;10677.626283080055;7496.58768767723;7583;7762.340201082745;7773.222677732408;8002.51984880909;9453.149216570542;10112.848307275544;10513.158947284352;10513.316634418738;10702.678919632424 04:39:07 INFO - PROCESS | 3775 | |3;mootools.html;1255.6233130060991;1342.422758213968;1393.3381643719233;1450.9274536273183;1685.4943516944913;6392.744290228386;7107.182673992486;7315.378192853601;7332.376747976428;7476.551406915575;7290.12518497781;7348.485606007582;7393.630318484081;7394.852102957938;7401.888971665429;1733.904635245061;2023.3323003408914;2143.6034333648286;2176.1186719378597;2176.4341271269427;2120.0883620043373;2141.8607790493647;2143.9678404823862;2148.1085349579985;2150.215171462413;2003.9098240579135;2019.767726711425;2023.2817349840816;2023.5244717491378;2042.765082015565;1978.0900785638623;2004.3485867093107;2007.4479518132557;2008.8794672319707;2008.8895110768901;2052.5176583502866;2064.6180456615575;2074.315475892952;2091.6653335466253;2092.299079808266;7255.492115551913;7289.744858929912;7303.89044164338;7305.561666300039;7315.2319006504085;4234.978825105885;4342.674299427524;4343.326784348399;4349.3475978603465;4356.760378179199;2655.9336016599545;2719.7688196503123;2851.572264160372;2856.2716507290716;2863.498887694645;782.8903953446522;816.5753808019856;866.8613021916464;871.2289623683023;883.2580632268925;9913.950430247874;9939.65211217604;9963.302568820185;9977.65078222266;9977.700668979869;3901.49280593521;3980.4825372701944;4021.8592349267633;4031.899202519902;4071.1043570414463;8280.875786863202;8323.458975166595;8330.083690794008;8338.416310858303;8352.206540378655;4416.315471101984;4429.601335879786;4429.933550996738;4438.090191510732;4438.423005009393;3922.3920292354733;4021.055052062763;4036.6972477064337;4040.2323558523785;4068.816903239361;3489.092835862694;3517.9472307915403;3634.01881492001;3693.8153092345274;3694.6859516941363;1112.2881355932209;1115.185914282562;1118.647625997808;1134.3364131982717;1139.8233273842402;748.296601194875;778.1207235823483;812.6180695073306;815.9714409995622;862.5988915154484;4804.6876952997945;5027.3464449621315;5032.370953630796;5105.923411148836;5115.7953681852305;804.7786858613928;832.8417600655856;850.3197442046338;862.9093945135796;873.1748497669641;3296.752743544244;3376.5272861799367;3392.5589673342306;3450.46517789743;3452.2405070884365;8905.287576993825;9142.04008579103;9221.631134754534;9225.677101301422;9227.584758685874;8005.239502247277;8213.630386632616;8601.870971935426;8667.609957551926;9073.274138068939;6885.827854303682;7029.4376449883885;7042.577445353295;7067.151941767021;7089.291070892869;5052.418971818288;5082;5126.641135120506;5207.635465517529;5254.816081437131;8372.539510326747;8386.454880432751;8441.11368306319;8454.196851299117;8519.74440766778;8014.919850801417;8315.376346774137;8326.875096873673;8594.183552562497;8610.526421046903;6175.073738939195;6298.496120310456;6322;6339.080833279241;6359.650219237987;6817.284185160487;6858.8285292866085;6859.1083159190985;6870.587764734132;6891.552049116792;6526.314736952741;6697.7655782047395;6725.092112564741;6754.223264324665;6825.35159159879;6189.473894718819;6227.688615569294;6232.18981532416;6238.6880655967925;6383.648899310397;5551.583631227755;5671.6597004179885;5705.201271822031;5710.486056254957;5798.159266906359;4271.508776490743;4299.505556861001;4310.224159651168;4367.847125350725;4378.1024889898135;4100.159467309254;4235.555266697076;4277.401163837128;4294.463192100988;4315.5900189481945 04:39:07 INFO - PROCESS | 3775 | |4;prototype.html;291.3488353529861;294.6420099579011;296.7107070606159;298.1695976704876;298.1859523500841;4799.976000119999;4827.275908613709;4840.652283642431;4871.12319782439;4881.267809828528;4729.787159577819;4766.42802863656;4771.236602143657;4780.832670856521;4783.880402989927;3504.9123771905715;3655.7258205634553;3672.4674922136273;3740.4576336431337;3823.9426408603895;3733.0667333166707;3747.5877653458097;3780.225053863965;3789.3368660484443;3804.9048773780737;3497.825108744565;3732.5894151643297;3741.6445437683515;3743.390342152873;3746.4754934309217;3639.94540081899;3754.530683664542;3756.5679946806194;3758.5489741231227;3765.2679767306936;3300.372929143455;3303.5209894565155;3314.8011119332677;3317.834108294576;3322.833858307099;4673.929891051637;4699.130660827758;4701.553352431513;4703.43558772946;4703.764811759398;4170.374443833419;4171.895702607429;4278.55075217104;4278.593533614302;4304.5910638489295;4886.853394398174;4969.552740253394;4975.253711943201;4986.800527978877;5029.1450453423;3575.4636804479537;3586.5337506124297;3593.7484376093685;3603.837827297778;3604.42329227325;4999.225120106389;5216.765245563959;5217.452167522393;5247.553957913582;5278.155495120763;3609.9819500902854;3614.6083757752926;3620.601733809279;3623.311570801592;3652.19651676636;3638.326909521747;3653.8721144759807;3663.908402289964;3672.944905826415;3676.669099780979;4205.432266643964;4206.894827629334;4225.767582782976;4238.067625122468;4254.85108021224;4883.706977581356;4962.230854217602;4971.726555039435;4983.700977941263;4994.65144411007;1276.8786965238287;1290.4644572502307;1292.868739852629;1302.863199364072;1303.641498587896;823.6417158536055;841.7348535211389;874.6326542852017;903.575319599787;905.7780843693338;4386.026288170272;4394.473177922707;4399.14216727735;4432.357308190294;4438.7114837535455;5088.1350170471105;5092.567131793765;5100.923486147711;5113.360829896263;5117.232415137759;4195.181939521825;4395.670324725658;4408.404865343202;4409.625181859577;4416.173648864729;2732.344237383014;2732.9863350683117;2747.6840163381066;2765.875535600903;2769.806113572071;4765.618750499952;4782.426108866958;4796.832110876103;4822.734749588736;4824;5036.748162591855;5174.586033117342;5198.506141916512;5214.947850521522;5222.3733152022005;4700.929486057712;4756.262779269219;4778.522147785263;4792.2811578262845;4813.78337974799;5080.415752188398;5091.796328146833;5103.260027296095;5116.309298244838;5116.692998420107;4744.976275118603;4967.304577359245;4978.477259887804;4983;5004.274380214775;4782.784774685217;4784.40194975628;4793.976030119967;4800.135975524299;4803.847076701636;3678.282734866675;3682.5765037021088;3682.6869716074434;3688.4467329899658;3694.8522059117336;4813.374261346003;5072.695638261716;5078.746062696924;5102.897942041212;5107.88022970478;4916.992016636509;4922.261660750916;4926.975365123151;4943.505649435027;4950.217921548167;4911.803527858846;4920.065187614342;4939.53074457926;4955.35580374549;4960.916415105737;4592.862214133581;4782.545658162469;4801.423829140525;4865.659403841697;4889.188716487963;4856.927146092882;4863.927041094457;4952.678075925053;4982.576480999156;4994.076095922266;4846.18268149444;4850.878728031827;4860.756962151949;4863.610911127172;4865.783554111472 04:39:07 INFO - PROCESS | 3775 | |5;yui.html;621.9098230756538;634.3339493531794;677.5088061155662;698.9825254368643;711.5197241861742;11799.469023893924;12756.55352062678;13016.349182540858;13121.147125436864;13138.408771605276;12254.387280635954;12941.48234070636;12988.350582470886;12990.74018519629;13001.934990325059;624.5940138909722;765.6401491299108;771.845630873826;774.6862520679134;791.8614242507567;790.7192946503994;792.7700966719644;794.9244821741926;795.2008231727107;796.0725754496005;836.4228682209256;836.5608055770708;836.9246767790897;837.1084794693662;838.1283465196188;643.3116565275158;801.7394346837301;802.9558374289412;807.3500831830374;832.379876991642;605.3401792046647;606.1029676079427;606.4178388746808;606.4360145065087;606.7057477123592;12897.87102128976;12916.289604071771;12938.288394138319;12947.223166610034;12955.740885182338;12427.689307767288;12771.808422873664;12885.484580616763;12914.483420663162;12938.547150849769;10740.355578665305;10927.945360273148;11140.220184587082;11304.547818087267;11307;4092.9181416371803;4161.146964872194;4167.541570427251;4270.295401258789;4380.408644832971;56608.43391566073;56944;57341.713291433276;58075.419245807425;58937.41062589362;9999.35004224723;10134.189264858793;10212.131968782736;10242.436665983443;10267.024632659886;17871.73192402115;17902.373416930604;17909.462716118538;17989.280428782964;18010.099495025457;6277;6348.77779277723;6427.260865000491;6438.549301548846;6444.903326450107;3533.363994481018;3631.6368363164;3648.5074514940143;3651.598324184338;3698.1863989922176;2614.542455070355;2710.471458065698;2713.4844379567817;2716.7011628720825;2718.5786203138546;490.9140900342426;517.1467079319078;518.5100080424038;524.1718085425019;558.2101326622865;521.9008388406266;553.1067326268048;554.4981791478718;558;571.2259887851901;8071.192880711882;8380.958095209486;8460.915390846136;8577.099404562556;8625.439346442461;561.7079118858171;596.2010905386802;606.1423086332878;606.4663096475074;609.9329073801878;3797.430385442206;3900;3922.9019274517796;4007.6192761687594;4010.8195131219163;93217;99792;102844;104020;104472.47763761284;53361.73319133457;72493.2750672497;77878.61060694774;85972.57013715016;90178;77224;79665;79813.60093199497;79882;80028.5998570015;7581.317681408479;7704.768856934301;8085.676572937016;8099;8235.670573177005;37885.81057094697;38229.42655860109;38477.80761096177;48341.27488087752;48969.2654610174;40180.31286072472;43618;53116.46883531115;60568.69715651393;61977;10970.945145274223;11068.335899846035;11219;11298.43507824589;11413.771724565628;12008.099392545419;12732.554360597334;13130.277834719182;13487.932560337136;13588.524401645895;12019.098567607289;12023.4589443477;12112.75774484523;12161.817572736592;12281.570145044881;11848.940755296513;12062;12127.332996685267;12363.75272494563;12541.74916501683;11725.530978760755;12557.971122320769;12679.429425676051;12688.936555317165;12699.682507937376;9955.253355998184;9997.800043999225;10000.000000000115;10095.495225238856;10394.948025259826;9035.27717782589;9552.283578731762;9677.854832177663;10546.209034322303;10593.470326483799 04:39:07 INFO - PROCESS | 3775 | __end_tp_report 04:39:07 INFO - PROCESS | 3775 | __start_cc_report 04:39:07 INFO - PROCESS | 3775 | _x_x_mozilla_cycle_collect,1053 04:39:07 INFO - PROCESS | 3775 | __end_cc_report 04:39:07 INFO - PROCESS | 3775 | __startTimestamp1465472347276__endTimestamp 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | ------- Summary: start ------- 04:39:07 INFO - PROCESS | 3775 | Number of tests: 6 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | [#0] dojo.html Cycles:165 Average:4620.55 Median:4751.41 stddev:487.82 (10.3%) stddev-sans-first:460.75 04:39:07 INFO - PROCESS | 3775 | Values: 2523.9 2575.6 2594.4 2619.4 2624.2 4534.3 4586.4 4687.2 4709.1 4732.0 4647.7 4686.1 4687.6 4704.7 4709.7 4136.6 4276.4 4369.2 4399.4 4495.2 4379.9 4418.2 4428.2 4439.6 4467.1 4144.3 4193.9 4261.2 4302.5 4307.8 4258.4 4265.6 4267.1 4311.3 4329.7 4280.6 4296.9 4303.3 4340.2 4348.4 4513.5 4583.9 4651.6 4664.0 4707.3 4984.7 5032.6 5040.9 5042.5 5046.8 5001.2 5063.5 5065.2 5070.4 5070.7 4510.6 4629.2 4674.6 4681.8 4687.8 5164.9 5168.5 5172.9 5186.4 5191.9 4715.0 4926.1 4926.8 4964.9 4970.3 4929.7 4978.2 4978.3 4980.8 5001.6 4939.6 4952.4 4955.2 4960.1 5006.2 4780.4 4822.6 4949.1 4957.8 5006.3 4236.4 4244.5 4261.8 4293.0 4302.4 3676.2 3685.9 3695.8 3710.7 3714.8 4179.0 4233.7 4263.6 4265.9 4308.1 4959.5 5021.2 5026.9 5036.1 5038.4 4309.3 4327.8 4329.4 4371.7 4378.5 4396.7 4534.0 4551.0 4551.6 4552.8 4726.8 4730.5 4758.1 4762.6 4799.7 5031.9 5033.2 5039.5 5075.4 5079.8 4570.1 4654.9 4671.3 4755.5 4798.4 4926.9 4941.5 4944.5 4945.4 4989.3 4992.9 5008.4 5021.2 5031.7 5054.6 4729.5 4802.1 4853.8 4860.0 4927.0 4821.9 4848.8 4857.3 4860.9 4906.1 4781.7 4791.5 4794.4 4843.7 4844.6 4751.4 4825.0 4864.1 4878.7 4886.6 4758.0 4766.6 4771.3 4789.8 4823.5 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | [#1] ext.html Cycles:180 Average:46210.45 Median:36917.04 stddev:84532.52 (229.0%) stddev-sans-first:84700.15 04:39:07 INFO - PROCESS | 3775 | Values: 553.5 568.2 574.0 578.6 581.4 27411.2 27928.7 30157.7 38436.2 39765.4 42362.4 42877.4 42888.0 42888.6 42926.6 7925.6 8088.6 8091.0 8091.9 8092.6 7875.4 7956.0 7969.2 7970.1 7971.8 7962.0 7992.1 7995.8 8000.1 8001.9 7898.6 7941.5 7947.4 7956.6 7959.0 7933.2 7950.4 7952.2 7993.1 7999.2 39922.0 40228.4 40252.8 40375.6 40434.0 3201.3 3248.2 3265.0 3429.9 3731.6 30165.0 30548.7 30700.7 30944.8 31823.0 3518.8 3565.9 3572.6 3631.1 3642.4 254586.0 255228.0 256022.0 256037.0 256988.0 32405.2 33374.7 33439.7 53731.2 54322.5 34628.3 34706.0 34773.1 34788.5 34835.8 13321.7 13446.7 13448.1 13448.3 13451.3 11172.8 11264.4 11270.9 11272.1 11274.8 7727.3 7735.0 7786.8 7796.9 7837.9 3067.4 3109.1 3127.8 3151.7 3167.9 829.2 853.5 910.8 932.0 1005.9 27940.4 28013.9 28094.9 28451.4 28466.0 902.7 937.1 939.8 987.5 1071.1 14602.3 14997.5 15033.3 15301.7 15357.8 388663.0 391417.0 392829.0 393235.0 393440.0 51092.5 51593.7 51755.5 51764.7 51786.5 1067.7 1137.7 1172.0 1195.6 1204.9 28727.9 29108.7 29411.6 29840.1 29998.4 43472.8 43820.8 43827.6 43907.0 43972.8 297498.0 297695.0 299882.0 299925.0 300363.0 22414.6 24983.3 25845.2 26113.7 26145.9 42936.6 43080.1 43272.4 43931.3 44236.1 35928.0 36982.6 37455.0 37652.2 37871.0 35165.3 36826.1 36855.6 39045.6 39873.6 36978.4 37004.6 37099.3 38075.2 38160.2 31588.7 33268.4 33541.8 34048.8 34258.0 25273.0 25364.9 25927.6 26093.5 26189.3 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | [#2] jquery.html Cycles:180 Average:24465.18 Median:4905.47 stddev:65538.70 (1336.0%) stddev-sans-first:65697.55 04:39:07 INFO - PROCESS | 3775 | Values: 350.8 353.8 358.7 363.2 368.6 15607.7 16331.8 17048.6 17084.4 17093.9 15681.1 15989.8 16248.0 16730.6 16771.1 4868.5 5092.9 5099.9 5106.7 5108.0 3736.8 3902.9 4942.4 5477.3 5801.9 5835.2 5846.2 5851.0 5877.1 5881.4 5689.4 5774.4 5836.6 5837.8 5856.5 3383.4 4822.6 5105.1 5108.5 5133.2 20148.3 20307.5 20383.5 20550.9 20645.9 1972.9 2019.8 2167.3 2506.4 2515.3 10562.7 12253.7 12768.7 13149.3 13558.2 1571.3 1642.0 1652.4 1700.9 1743.9 63975.0 65334.7 66657.7 67028.0 68067.0 8635.8 8701.8 9240.8 9431.0 9641.7 12581.4 12648.9 12650.6 12677.7 12681.4 7125.9 7136.7 7176.4 7200.4 7212.2 6845.8 6905.1 7030.4 7049.0 7140.3 5890.9 5912.7 5949.7 6002.6 6028.4 1515.4 1591.3 1616.5 1711.6 1712.5 798.6 808.7 858.9 932.2 983.3 16746.4 17076.6 17110.7 17299.7 17316.2 900.3 912.3 926.9 958.4 964.2 9123.8 9651.9 9926.3 9942.4 10208.3 380748.0 381240.0 398853.0 405518.0 416968.0 78398.2 80863.2 83171.6 83871.0 84059.6 945.5 957.3 958.3 977.9 984.6 15413.4 15550.6 15629.5 15866.2 16038.8 33701.0 35043.8 35442.5 36240.1 36857.6 39564.8 50023.2 52146.5 52546.0 53186.7 7402.3 7506.7 7735.1 7753.7 7831.8 8162.6 11587.9 11746.9 11881.4 11963.8 5096.3 6323.6 9835.5 9905.0 10409.2 10154.8 10159.4 10267.9 10277.2 10284.4 10287.6 10346.8 10475.0 10650.5 10677.6 7496.6 7583.0 7762.3 7773.2 8002.5 9453.1 10112.8 10513.2 10513.3 10702.7 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | [#3] mootools.html Cycles:180 Average:4832.94 Median:5611.62 stddev:2662.43 (47.4%) stddev-sans-first:2656.32 04:39:07 INFO - PROCESS | 3775 | Values: 1255.6 1342.4 1393.3 1450.9 1685.5 6392.7 7107.2 7315.4 7332.4 7476.6 7290.1 7348.5 7393.6 7394.9 7401.9 1733.9 2023.3 2143.6 2176.1 2176.4 2120.1 2141.9 2144.0 2148.1 2150.2 2003.9 2019.8 2023.3 2023.5 2042.8 1978.1 2004.3 2007.4 2008.9 2008.9 2052.5 2064.6 2074.3 2091.7 2092.3 7255.5 7289.7 7303.9 7305.6 7315.2 4235.0 4342.7 4343.3 4349.3 4356.8 2655.9 2719.8 2851.6 2856.3 2863.5 782.9 816.6 866.9 871.2 883.3 9914.0 9939.7 9963.3 9977.7 9977.7 3901.5 3980.5 4021.9 4031.9 4071.1 8280.9 8323.5 8330.1 8338.4 8352.2 4416.3 4429.6 4429.9 4438.1 4438.4 3922.4 4021.1 4036.7 4040.2 4068.8 3489.1 3517.9 3634.0 3693.8 3694.7 1112.3 1115.2 1118.6 1134.3 1139.8 748.3 778.1 812.6 816.0 862.6 4804.7 5027.3 5032.4 5105.9 5115.8 804.8 832.8 850.3 862.9 873.2 3296.8 3376.5 3392.6 3450.5 3452.2 8905.3 9142.0 9221.6 9225.7 9227.6 8005.2 8213.6 8601.9 8667.6 9073.3 6885.8 7029.4 7042.6 7067.2 7089.3 5052.4 5082.0 5126.6 5207.6 5254.8 8372.5 8386.5 8441.1 8454.2 8519.7 8014.9 8315.4 8326.9 8594.2 8610.5 6175.1 6298.5 6322.0 6339.1 6359.7 6817.3 6858.8 6859.1 6870.6 6891.6 6526.3 6697.8 6725.1 6754.2 6825.4 6189.5 6227.7 6232.2 6238.7 6383.6 5551.6 5671.7 5705.2 5710.5 5798.2 4271.5 4299.5 4310.2 4367.8 4378.1 4100.2 4235.6 4277.4 4294.5 4315.6 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | [#4] prototype.html Cycles:180 Average:4132.75 Median:4766.02 stddev:1184.46 (24.9%) stddev-sans-first:1152.16 04:39:07 INFO - PROCESS | 3775 | Values: 291.3 294.6 296.7 298.2 298.2 4800.0 4827.3 4840.7 4871.1 4881.3 4729.8 4766.4 4771.2 4780.8 4783.9 3504.9 3655.7 3672.5 3740.5 3823.9 3733.1 3747.6 3780.2 3789.3 3804.9 3497.8 3732.6 3741.6 3743.4 3746.5 3639.9 3754.5 3756.6 3758.5 3765.3 3300.4 3303.5 3314.8 3317.8 3322.8 4673.9 4699.1 4701.6 4703.4 4703.8 4170.4 4171.9 4278.6 4278.6 4304.6 4886.9 4969.6 4975.3 4986.8 5029.1 3575.5 3586.5 3593.7 3603.8 3604.4 4999.2 5216.8 5217.5 5247.6 5278.2 3610.0 3614.6 3620.6 3623.3 3652.2 3638.3 3653.9 3663.9 3672.9 3676.7 4205.4 4206.9 4225.8 4238.1 4254.9 4883.7 4962.2 4971.7 4983.7 4994.7 1276.9 1290.5 1292.9 1302.9 1303.6 823.6 841.7 874.6 903.6 905.8 4386.0 4394.5 4399.1 4432.4 4438.7 5088.1 5092.6 5100.9 5113.4 5117.2 4195.2 4395.7 4408.4 4409.6 4416.2 2732.3 2733.0 2747.7 2765.9 2769.8 4765.6 4782.4 4796.8 4822.7 4824.0 5036.7 5174.6 5198.5 5214.9 5222.4 4700.9 4756.3 4778.5 4792.3 4813.8 5080.4 5091.8 5103.3 5116.3 5116.7 4745.0 4967.3 4978.5 4983.0 5004.3 4782.8 4784.4 4794.0 4800.1 4803.8 3678.3 3682.6 3682.7 3688.4 3694.9 4813.4 5072.7 5078.7 5102.9 5107.9 4917.0 4922.3 4927.0 4943.5 4950.2 4911.8 4920.1 4939.5 4955.4 4960.9 4592.9 4782.5 4801.4 4865.7 4889.2 4856.9 4863.9 4952.7 4982.6 4994.1 4846.2 4850.9 4860.8 4863.6 4865.8 04:39:07 INFO - PROCESS | 3775 | 04:39:07 INFO - PROCESS | 3775 | [#5] yui.html Cycles:180 Average:17299.64 Median:23999.20 stddev:24757.38 (103.2%) stddev-sans-first:24795.16 04:39:07 INFO - PROCESS | 3775 | Values: 621.9 634.3 677.5 699.0 711.5 11799.5 12756.6 13016.3 13121.1 13138.4 12254.4 12941.5 12988.4 12990.7 13001.9 624.6 765.6 771.8 774.7 791.9 790.7 792.8 794.9 795.2 796.1 836.4 836.6 836.9 837.1 838.1 643.3 801.7 803.0 807.4 832.4 605.3 606.1 606.4 606.4 606.7 12897.9 12916.3 12938.3 12947.2 12955.7 12427.7 12771.8 12885.5 12914.5 12938.5 10740.4 10927.9 11140.2 11304.5 11307.0 4092.9 4161.1 4167.5 4270.3 4380.4 56608.4 56944.0 57341.7 58075.4 58937.4 9999.4 10134.2 10212.1 10242.4 10267.0 17871.7 17902.4 17909.5 17989.3 18010.1 6277.0 6348.8 6427.3 6438.5 6444.9 3533.4 3631.6 3648.5 3651.6 3698.2 2614.5 2710.5 2713.5 2716.7 2718.6 490.9 517.1 518.5 524.2 558.2 521.9 553.1 554.5 558.0 571.2 8071.2 8381.0 8460.9 8577.1 8625.4 561.7 596.2 606.1 606.5 609.9 3797.4 3900.0 3922.9 4007.6 4010.8 93217.0 99792.0 102844.0 104020.0 104472.5 53361.7 72493.3 77878.6 85972.6 90178.0 77224.0 79665.0 79813.6 79882.0 80028.6 7581.3 7704.8 8085.7 8099.0 8235.7 37885.8 38229.4 38477.8 48341.3 48969.3 40180.3 43618.0 53116.5 60568.7 61977.0 10970.9 11068.3 11219.0 11298.4 11413.8 12008.1 12732.6 13130.3 13487.9 13588.5 12019.1 12023.5 12112.8 12161.8 12281.6 11848.9 12062.0 12127.3 12363.8 12541.7 11725.5 12558.0 12679.4 12688.9 12699.7 9955.3 9997.8 10000.0 10095.5 10394.9 9035.3 9552.3 9677.9 10546.2 10593.5 04:39:07 INFO - PROCESS | 3775 | -------- Summary: end -------- 04:39:07 INFO - PROCESS | 3775 | 04:39:08 INFO - TEST-INFO | 3775: exit 0 04:39:08 INFO - TEST-OK | dromaeo_css | took 1118754ms 04:39:08 INFO - TEST-START | kraken 04:39:08 INFO - operating with platform_type : linux_ 04:39:08 INFO - Initialising browser for kraken test... 04:39:08 INFO - TEST-INFO | started process 3955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbBFkaU/profile http://localhost:58669/getInfo.html) 04:39:12 INFO - PROCESS | 3955 | __metrics Screen width/height:1600/1200 04:39:12 INFO - PROCESS | 3955 | colorDepth:24 04:39:12 INFO - PROCESS | 3955 | Browser inner width/height: 1024/697 04:39:12 INFO - PROCESS | 3955 | __metrics 04:39:13 ERROR - PROCESS | 3955 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:39:13 INFO - PROCESS | 3955 | console.error: PushService: 04:39:13 INFO - PROCESS | 3955 | stateChangeProcessEnqueue: Error transitioning state 04:39:13 INFO - PROCESS | 3955 | UnknownError 04:39:14 INFO - TEST-INFO | 3955: exit 0 04:39:14 INFO - Browser initialized. 04:39:14 INFO - Running cycle 1/1 for kraken test... 04:39:14 INFO - TEST-INFO | started process 4036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbBFkaU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:26 INFO - PROCESS | 4036 | RSS: Main: 174968832 04:39:26 INFO - PROCESS | 4036 | 04:39:29 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58669/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:29 INFO - PROCESS | 4036 | RSS: Main: 232062976 04:39:29 INFO - PROCESS | 4036 | 04:39:32 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58669/tests/kraken/driver.html?testName=audio-dft) 04:39:33 INFO - PROCESS | 4036 | RSS: Main: 220692480 04:39:33 INFO - PROCESS | 4036 | 04:39:36 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58669/tests/kraken/driver.html?testName=audio-fft) 04:39:37 INFO - PROCESS | 4036 | RSS: Main: 287870976 04:39:37 INFO - PROCESS | 4036 | 04:39:39 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58669/tests/kraken/driver.html?testName=audio-oscillator) 04:39:40 INFO - PROCESS | 4036 | RSS: Main: 197734400 04:39:40 INFO - PROCESS | 4036 | 04:39:42 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58669/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:42 INFO - PROCESS | 4036 | RSS: Main: 201478144 04:39:42 INFO - PROCESS | 4036 | 04:39:46 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58669/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:46 INFO - PROCESS | 4036 | RSS: Main: 237953024 04:39:46 INFO - PROCESS | 4036 | 04:39:50 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58669/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:50 INFO - PROCESS | 4036 | RSS: Main: 238706688 04:39:50 INFO - PROCESS | 4036 | 04:39:53 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58669/tests/kraken/driver.html?testName=json-parse-financial) 04:39:54 INFO - PROCESS | 4036 | RSS: Main: 238481408 04:39:54 INFO - PROCESS | 4036 | 04:39:56 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58669/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:56 INFO - PROCESS | 4036 | RSS: Main: 221384704 04:39:56 INFO - PROCESS | 4036 | 04:39:58 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:59 INFO - PROCESS | 4036 | RSS: Main: 227348480 04:39:59 INFO - PROCESS | 4036 | 04:40:01 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:40:02 INFO - PROCESS | 4036 | RSS: Main: 235778048 04:40:02 INFO - PROCESS | 4036 | 04:40:04 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:40:05 INFO - PROCESS | 4036 | RSS: Main: 240103424 04:40:05 INFO - PROCESS | 4036 | 04:40:08 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:40:09 INFO - PROCESS | 4036 | RSS: Main: 240611328 04:40:09 INFO - PROCESS | 4036 | 04:40:10 INFO - PROCESS | 4036 | Cycle 1(1): loaded http://localhost:58669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58669/tests/kraken/driver.html?testName=ai-astar) 04:40:11 INFO - PROCESS | 4036 | RSS: Main: 282087424 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | __start_tp_report 04:40:11 INFO - PROCESS | 4036 | _x_x_mozilla_page_load 04:40:11 INFO - PROCESS | 4036 | _x_x_mozilla_page_load_details 04:40:11 INFO - PROCESS | 4036 | |i|pagename|runs| 04:40:11 INFO - PROCESS | 4036 | |0;ai-astar;113;108;113;116;113;113;112;114;115;113 04:40:11 INFO - PROCESS | 4036 | |1;audio-beat-detection;151;130;136;184;134;163;163;135;192;130 04:40:11 INFO - PROCESS | 4036 | |2;audio-dft;162;162;161;161;162;163;162;164;162;162 04:40:11 INFO - PROCESS | 4036 | |3;audio-fft;86;74;76;113;75;77;75;75;98;76 04:40:11 INFO - PROCESS | 4036 | |4;audio-oscillator;86;86;114;87;87;86;120;87;86;131 04:40:11 INFO - PROCESS | 4036 | |5;imaging-gaussian-blur;117;118;117;117;117;116;117;117;117;118 04:40:11 INFO - PROCESS | 4036 | |6;imaging-darkroom;146;147;146;146;147;146;146;146;147;146 04:40:11 INFO - PROCESS | 4036 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 04:40:11 INFO - PROCESS | 4036 | |8;json-parse-financial;65;64;65;64;65;65;64;64;63;77 04:40:11 INFO - PROCESS | 4036 | |9;json-stringify-tinderbox;65;65;66;65;64;65;67;66;66;64 04:40:11 INFO - PROCESS | 4036 | |10;stanford-crypto-aes;84;83;83;85;86;85;85;91;122;90 04:40:11 INFO - PROCESS | 4036 | |11;stanford-crypto-ccm;141;134;133;135;131;141;136;129;144;134 04:40:11 INFO - PROCESS | 4036 | |12;stanford-crypto-pbkdf2;175;169;174;166;171;168;168;170;175;169 04:40:11 INFO - PROCESS | 4036 | |13;stanford-crypto-sha256-iterative;70;68;68;67;67;75;68;69;68;66 04:40:11 INFO - PROCESS | 4036 | __end_tp_report 04:40:11 INFO - PROCESS | 4036 | __start_cc_report 04:40:11 INFO - PROCESS | 4036 | _x_x_mozilla_cycle_collect,1932 04:40:11 INFO - PROCESS | 4036 | __end_cc_report 04:40:11 INFO - PROCESS | 4036 | __startTimestamp1465472411047__endTimestamp 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | ------- Summary: start ------- 04:40:11 INFO - PROCESS | 4036 | Number of tests: 14 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#0] ai-astar Cycles:10 Average:113.00 Median:113.00 stddev:2.11 (1.9%) stddev-sans-first:2.24 04:40:11 INFO - PROCESS | 4036 | Values: 113.0 108.0 113.0 116.0 113.0 113.0 112.0 114.0 115.0 113.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#1] audio-beat-detection Cycles:10 Average:151.80 Median:157.00 stddev:22.86 (14.6%) stddev-sans-first:24.25 04:40:11 INFO - PROCESS | 4036 | Values: 151.0 130.0 136.0 184.0 134.0 163.0 163.0 135.0 192.0 130.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 04:40:11 INFO - PROCESS | 4036 | Values: 162.0 162.0 161.0 161.0 162.0 163.0 162.0 164.0 162.0 162.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:13.07 (17.2%) stddev-sans-first:13.81 04:40:11 INFO - PROCESS | 4036 | Values: 86.0 74.0 76.0 113.0 75.0 77.0 75.0 75.0 98.0 76.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#4] audio-oscillator Cycles:10 Average:97.00 Median:86.00 stddev:17.51 (20.4%) stddev-sans-first:18.11 04:40:11 INFO - PROCESS | 4036 | Values: 86.0 86.0 114.0 87.0 87.0 86.0 120.0 87.0 86.0 131.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:40:11 INFO - PROCESS | 4036 | Values: 117.0 118.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 04:40:11 INFO - PROCESS | 4036 | Values: 146.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:40:11 INFO - PROCESS | 4036 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:65.00 stddev:4.06 (6.2%) stddev-sans-first:4.30 04:40:11 INFO - PROCESS | 4036 | Values: 65.0 64.0 65.0 64.0 65.0 65.0 64.0 64.0 63.0 77.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 04:40:11 INFO - PROCESS | 4036 | Values: 65.0 65.0 66.0 65.0 64.0 65.0 67.0 66.0 66.0 64.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:85.00 stddev:11.77 (13.8%) stddev-sans-first:12.32 04:40:11 INFO - PROCESS | 4036 | Values: 84.0 83.0 83.0 85.0 86.0 85.0 85.0 91.0 122.0 90.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:135.50 stddev:4.78 (3.5%) stddev-sans-first:4.68 04:40:11 INFO - PROCESS | 4036 | Values: 141.0 134.0 133.0 135.0 131.0 141.0 136.0 129.0 144.0 134.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:170.50 stddev:3.17 (1.9%) stddev-sans-first:2.92 04:40:11 INFO - PROCESS | 4036 | Values: 175.0 169.0 174.0 166.0 171.0 168.0 168.0 170.0 175.0 169.0 04:40:11 INFO - PROCESS | 4036 | 04:40:11 INFO - PROCESS | 4036 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:2.50 (3.7%) stddev-sans-first:2.60 04:40:11 INFO - PROCESS | 4036 | Values: 70.0 68.0 68.0 67.0 67.0 75.0 68.0 69.0 68.0 66.0 04:40:11 INFO - PROCESS | 4036 | -------- Summary: end -------- 04:40:11 INFO - PROCESS | 4036 | 04:40:12 INFO - TEST-INFO | 4036: exit 0 04:40:12 INFO - TEST-OK | kraken | took 64116ms 04:40:12 INFO - SUITE-END | took 1182s 04:40:12 INFO - Completed test suite (00:19:42) 04:40:12 INFO - javascript benchmark 04:40:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2523.911663091792, 2575.562154433746, 2594.390318275205, 2619.3582572269797, 2624.2389706984977, 4534.251848445011, 4586.38083858679, 4687.226607609745, 4709.128811169936, 4731.958969026813, 4647.744374059425, 4686.133065382906, 4687.578117969382, 4704.670673052888, 4709.717416954985, 4136.627703506684, 4276.358546218061, 4369.213541562517, 4399.406080179183, 4495.190865644183, 4379.948812285044, 4418.160549495586, 4428.158649856517, 4439.600435960763, 4467.10657868426, 4144.254034273845, 4193.853215137486, 4261.21167583998, 4302.5052119006405, 4307.82768689252, 4258.446401967755, 4265.55211702773, 4267.061246525759, 4311.2670845955945, 4329.675274354436, 4280.5719428057255, 4296.8710938671575, 4303.31147016479, 4340.153670034345, 4348.434703488558, 4513.480949690795, 4583.931241031387, 4651.581357677791, 4663.953360466419, 4707.270373092176, 4984.725840078794, 5032.597392208614, 5040.873978150539, 5042.470540593222, 5046.823361182341, 5001.224810154432, 5063.493650634907, 5065.1642478990925, 5070.3915530136255, 5070.670406423571, 4510.616597589209, 4629.213033784265, 4674.626029917598, 4681.765911704401, 4687.789049492781, 5164.870878227999, 5168.508991645787, 5172.8965420691375, 5186.4035635902355, 5191.896162076738, 4714.95285047152, 4926.113299606033, 4926.827561035347, 4964.925526117111, 4970.254461830682, 4929.704217746875, 4978.178600530872, 4978.253262010655, 4980.825671101494, 5001.599872010231, 4939.604831613462, 4952.405711314594, 4955.231939049453, 4960.107180707508, 5006.1739812930455, 4780.426348838092, 4822.590079843182, 4949.059678661043, 4957.752112394366, 5006.299118123466, 4236.364545318165, 4244.511881133647, 4261.829526818955, 4293.0, 4302.376155457441, 3676.191237927652, 3685.9262814743556, 3695.8336874840697, 3710.7402481826553, 3714.832832522543, 4178.958210417918, 4233.661307095486, 4263.616274535307, 4265.914681706348, 4308.052228509723, 4959.479254678279, 5021.246812978083, 5026.899462010812, 5036.143855544567, 5038.445770965191, 4309.288967320357, 4327.805248763813, 4329.437173167531, 4371.737695738202, 4378.474583050054, 4396.714213576107, 4534.047849951481, 4550.97724511382, 4551.5676010778925, 4552.795124219352, 4726.787294571684, 4730.52694730531, 4758.072175925661, 4762.571368576845, 4799.66402351839, 5031.899362012666, 5033.169527028, 5039.546440820343, 5075.416327122428, 5079.796808127781, 4570.131674981742, 4654.883627909329, 4671.299305104126, 4755.500672429345, 4798.352222450064, 4926.926096108633, 4941.456439791692, 4944.5302696245235, 4945.357103576512, 4989.276554899447, 4992.900141997067, 5008.424031236309, 5021.246812977936, 5031.6729412588065, 5054.595632349477, 4729.527047295243, 4802.135615589088, 4853.757312134449, 4859.95140048595, 4927.0, 4821.927671085006, 4848.75756212195, 4857.319975203403, 4860.878478038077, 4906.092372911023, 4781.665283430266, 4791.544803243686, 4794.448638406628, 4843.660943733905, 4844.636652251025, 4751.40607424072, 4825.0, 4864.100141473838, 4878.707277563358, 4886.609071274218, 4758.04839032188, 4766.642501812308, 4771.332013518179, 4789.784459699252, 4823.469418363907], "value": 4589.072080156765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.5073784331944, 568.2385603291589, 573.9971300143496, 578.5892016668165, 581.3605034462092, 27411.177664670067, 27928.720712792892, 30157.69842301579, 38436.23127537448, 39765.40351894724, 42362.364564531556, 42877.35683964743, 42888.0, 42888.57111428893, 42926.57073429273, 7925.643346049427, 8088.595570221495, 8090.959545202266, 8091.919080809175, 8092.635831387602, 7875.4487185897015, 7956.045274567031, 7969.163237860028, 7970.083440404341, 7971.800704982393, 7961.96019019907, 7992.080910695257, 7995.800104997364, 8000.119986801447, 8001.8799718004275, 7898.565578893159, 7941.523508589503, 7947.403944704141, 7956.641951112156, 7958.960205198937, 7933.246341597539, 7950.403719721044, 7952.165022672594, 7993.080795708452, 7999.240072193191, 39922.0, 40228.39657405141, 40252.79873600643, 40375.59624403777, 40434.0, 3201.3117179806454, 3248.2366643838677, 3264.9927970769754, 3429.8971030869116, 3731.5522137343423, 30165.0, 30548.69451305481, 30700.692993070006, 30944.845275773478, 31823.0, 3518.841652125635, 3565.9108522286892, 3572.6427357264065, 3631.1466805300734, 3642.3990041643096, 254585.99999999814, 255228.0, 256022.0, 256037.0, 256988.0, 32405.18987025296, 33374.666253337644, 33439.66560334365, 53731.19403208955, 54322.45677543253, 34628.30743385118, 34706.0, 34773.130671732906, 34788.478172827425, 34835.825820870734, 13321.733565328834, 13446.731065378637, 13448.058635895393, 13448.260345680887, 13451.26018068996, 11172.776544469227, 11264.43677816106, 11270.943645281885, 11272.098232141409, 11274.774504510027, 7727.343175830118, 7734.955780969497, 7786.844263114706, 7796.883046754303, 7837.921620783719, 3067.4478593852873, 3109.144985129062, 3127.8436078196, 3151.7163455289133, 3167.857446414917, 829.2288172000098, 853.47511280562, 910.8129204182119, 931.993447077155, 1005.8994100590029, 27940.44119117606, 28013.879444822385, 28094.87620495157, 28451.430971380458, 28466.0, 902.697596305232, 937.0676177203726, 939.7650587353162, 987.4963768478128, 1071.1430855315716, 14602.34289456977, 14997.475088371855, 15033.323500442506, 15301.693966120616, 15357.848161387717, 388663.0, 391417.0, 392829.0, 393235.0, 393440.0, 51092.489075109515, 51593.74203128961, 51755.48244517582, 51764.74117629388, 51786.48213517892, 1067.6583493282076, 1137.6814491942268, 1172.0447835014606, 1195.5875223048035, 1204.9036077113985, 28727.856360718062, 29108.7089129106, 29411.55882661719, 29840.10479685613, 29998.4000319988, 43472.78263608662, 43820.78089609532, 43827.56172438235, 43907.0, 43972.780136099114, 297498.0, 297695.0, 299882.0, 299925.0, 300363.0, 22414.551708965402, 24983.250502484956, 25845.22464326073, 26113.73886261189, 26145.869270653526, 42936.57063429326, 43080.138397232506, 43272.35091473693, 43931.34102988522, 44236.11527769491, 35928.0, 36982.59613125138, 37455.0, 37652.246955061295, 37871.0, 35165.296694066485, 36826.07934801544, 36855.63144368522, 39045.6095439042, 39873.60126398815, 36978.44532331963, 37004.62995370012, 37099.25801483901, 38075.23849523049, 38160.23679526339, 31588.684113159492, 33268.350228940166, 33541.83229083937, 34048.82975585106, 34258.0, 25273.0, 25364.873175634002, 25927.611085834105, 26093.527075327904, 26189.34526636773], "value": 16616.308509511357, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.8000439749343, 353.7559084231879, 358.71482171673534, 363.2063940290467, 368.5816598161088, 15607.687846243083, 16331.836681633195, 17048.573785655335, 17084.402045928397, 17093.914530427344, 15681.137537435436, 15989.760153597705, 16248.0, 16730.58173545662, 16771.077590732504, 4868.537488938545, 5092.949070509303, 5099.923501147486, 5106.69359838409, 5107.974460127694, 3736.8131593420358, 3902.8829135125993, 4942.406911170665, 5477.287952566161, 5801.912971305413, 5835.212246346752, 5846.181534585162, 5851.0, 5877.14781356703, 5881.3530511643685, 5689.402612725646, 5774.364819869811, 5836.620619659709, 5837.795677151301, 5856.472917437451, 3383.374075795961, 4822.590079843218, 5105.132127538291, 5108.514691104339, 5133.178691409356, 20148.29480968159, 20307.492312692302, 20383.49041273965, 20550.897245513825, 20645.89677051605, 1972.881627102364, 2019.8385928091407, 2167.2739632223224, 2506.3608779761225, 2515.295717199187, 10562.683119506428, 12253.69365765863, 12768.744625107538, 13149.342532873414, 13558.186508809504, 1571.347890625389, 1642.0, 1652.4051341517045, 1700.9404670836584, 1743.947681569555, 63975.0, 65334.673326633536, 66657.66671166662, 67028.0, 68066.9789953156, 8635.78410539729, 8701.825963480822, 9240.7689807754, 9431.0, 9641.746572945613, 12581.433835477426, 12648.936755316348, 12650.620481385573, 12677.683057923441, 12681.35142431478, 7125.857482850418, 7136.678849451787, 7176.390006849476, 7200.423966082701, 7212.206657267697, 6845.828854278683, 6905.067815844796, 7030.354531441389, 7049.0, 7140.250273721288, 5890.852728681817, 5912.733926973297, 5949.672767997715, 6002.579819412686, 6028.367021462771, 1515.4241388272385, 1591.283922234999, 1616.4665660332062, 1711.606330543957, 1712.4605749188966, 798.6366203377565, 808.6846130009301, 858.8625819868791, 932.1750251027889, 983.257640481432, 16746.4138755143, 17076.57308567271, 17110.743338849927, 17299.74050389245, 17316.220770065378, 900.2797761790541, 912.3385545479474, 926.9073092690677, 958.4009993753904, 964.2141654551518, 9123.81752364949, 9651.890032646195, 9926.305158638826, 9942.403455792675, 10208.285420020677, 380748.0, 381240.0, 398853.0, 405518.0, 416968.0, 78398.21601783909, 80863.19136808674, 83171.58414207891, 83871.0, 84059.5797021011, 945.5036106044245, 957.2724729205854, 958.3483231402573, 977.8826540815147, 984.6307634637011, 15413.383464661736, 15550.611234719223, 15629.452969146025, 15866.20668966524, 16038.839611603735, 33701.0, 35043.82478087593, 35442.46836297406, 36240.09399765027, 36857.63142368542, 39564.80217598894, 50023.24965125453, 52146.47853521416, 52546.0, 53186.73406632942, 7402.29678180572, 7506.662200201114, 7735.149133595188, 7753.651085701044, 7831.765047048598, 8162.632681529227, 11587.884121159017, 11746.941265293619, 11881.405929703653, 11963.820542692041, 5096.337476128079, 6323.557350985387, 9835.459049752333, 9904.950475247577, 10409.219308551737, 10154.847677284699, 10159.44123073238, 10267.897321026694, 10277.229207809294, 10284.382937023802, 10287.639932602324, 10346.793064138525, 10475.0, 10650.467476626292, 10677.626283080055, 7496.58768767723, 7583.0, 7762.340201082745, 7773.222677732408, 8002.51984880909, 9453.149216570542, 10112.848307275544, 10513.158947284352, 10513.316634418738, 10702.678919632424], "value": 8239.686869565496, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.6233130060991, 1342.422758213968, 1393.3381643719233, 1450.9274536273183, 1685.4943516944913, 6392.744290228386, 7107.182673992486, 7315.378192853601, 7332.376747976428, 7476.551406915575, 7290.12518497781, 7348.485606007582, 7393.630318484081, 7394.852102957938, 7401.888971665429, 1733.904635245061, 2023.3323003408914, 2143.6034333648286, 2176.1186719378597, 2176.4341271269427, 2120.0883620043373, 2141.8607790493647, 2143.9678404823862, 2148.1085349579985, 2150.215171462413, 2003.9098240579135, 2019.767726711425, 2023.2817349840816, 2023.5244717491378, 2042.765082015565, 1978.0900785638623, 2004.3485867093107, 2007.4479518132557, 2008.8794672319707, 2008.8895110768901, 2052.5176583502866, 2064.6180456615575, 2074.315475892952, 2091.6653335466253, 2092.299079808266, 7255.492115551913, 7289.744858929912, 7303.89044164338, 7305.561666300039, 7315.2319006504085, 4234.978825105885, 4342.674299427524, 4343.326784348399, 4349.3475978603465, 4356.760378179199, 2655.9336016599545, 2719.7688196503123, 2851.572264160372, 2856.2716507290716, 2863.498887694645, 782.8903953446522, 816.5753808019856, 866.8613021916464, 871.2289623683023, 883.2580632268925, 9913.950430247874, 9939.65211217604, 9963.302568820185, 9977.65078222266, 9977.700668979869, 3901.49280593521, 3980.4825372701944, 4021.8592349267633, 4031.899202519902, 4071.1043570414463, 8280.875786863202, 8323.458975166595, 8330.083690794008, 8338.416310858303, 8352.206540378655, 4416.315471101984, 4429.601335879786, 4429.933550996738, 4438.090191510732, 4438.423005009393, 3922.3920292354733, 4021.055052062763, 4036.6972477064337, 4040.2323558523785, 4068.816903239361, 3489.092835862694, 3517.9472307915403, 3634.01881492001, 3693.8153092345274, 3694.6859516941363, 1112.2881355932209, 1115.185914282562, 1118.647625997808, 1134.3364131982717, 1139.8233273842402, 748.296601194875, 778.1207235823483, 812.6180695073306, 815.9714409995622, 862.5988915154484, 4804.6876952997945, 5027.3464449621315, 5032.370953630796, 5105.923411148836, 5115.7953681852305, 804.7786858613928, 832.8417600655856, 850.3197442046338, 862.9093945135796, 873.1748497669641, 3296.752743544244, 3376.5272861799367, 3392.5589673342306, 3450.46517789743, 3452.2405070884365, 8905.287576993825, 9142.04008579103, 9221.631134754534, 9225.677101301422, 9227.584758685874, 8005.239502247277, 8213.630386632616, 8601.870971935426, 8667.609957551926, 9073.274138068939, 6885.827854303682, 7029.4376449883885, 7042.577445353295, 7067.151941767021, 7089.291070892869, 5052.418971818288, 5082.0, 5126.641135120506, 5207.635465517529, 5254.816081437131, 8372.539510326747, 8386.454880432751, 8441.11368306319, 8454.196851299117, 8519.74440766778, 8014.919850801417, 8315.376346774137, 8326.875096873673, 8594.183552562497, 8610.526421046903, 6175.073738939195, 6298.496120310456, 6322.0, 6339.080833279241, 6359.650219237987, 6817.284185160487, 6858.8285292866085, 6859.1083159190985, 6870.587764734132, 6891.552049116792, 6526.314736952741, 6697.7655782047395, 6725.092112564741, 6754.223264324665, 6825.35159159879, 6189.473894718819, 6227.688615569294, 6232.18981532416, 6238.6880655967925, 6383.648899310397, 5551.583631227755, 5671.6597004179885, 5705.201271822031, 5710.486056254957, 5798.159266906359, 4271.508776490743, 4299.505556861001, 4310.224159651168, 4367.847125350725, 4378.1024889898135, 4100.159467309254, 4235.555266697076, 4277.401163837128, 4294.463192100988, 4315.5900189481945], "value": 3912.8678021129817, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.3488353529861, 294.6420099579011, 296.7107070606159, 298.1695976704876, 298.1859523500841, 4799.976000119999, 4827.275908613709, 4840.652283642431, 4871.12319782439, 4881.267809828528, 4729.787159577819, 4766.42802863656, 4771.236602143657, 4780.832670856521, 4783.880402989927, 3504.9123771905715, 3655.7258205634553, 3672.4674922136273, 3740.4576336431337, 3823.9426408603895, 3733.0667333166707, 3747.5877653458097, 3780.225053863965, 3789.3368660484443, 3804.9048773780737, 3497.825108744565, 3732.5894151643297, 3741.6445437683515, 3743.390342152873, 3746.4754934309217, 3639.94540081899, 3754.530683664542, 3756.5679946806194, 3758.5489741231227, 3765.2679767306936, 3300.372929143455, 3303.5209894565155, 3314.8011119332677, 3317.834108294576, 3322.833858307099, 4673.929891051637, 4699.130660827758, 4701.553352431513, 4703.43558772946, 4703.764811759398, 4170.374443833419, 4171.895702607429, 4278.55075217104, 4278.593533614302, 4304.5910638489295, 4886.853394398174, 4969.552740253394, 4975.253711943201, 4986.800527978877, 5029.1450453423, 3575.4636804479537, 3586.5337506124297, 3593.7484376093685, 3603.837827297778, 3604.42329227325, 4999.225120106389, 5216.765245563959, 5217.452167522393, 5247.553957913582, 5278.155495120763, 3609.9819500902854, 3614.6083757752926, 3620.601733809279, 3623.311570801592, 3652.19651676636, 3638.326909521747, 3653.8721144759807, 3663.908402289964, 3672.944905826415, 3676.669099780979, 4205.432266643964, 4206.894827629334, 4225.767582782976, 4238.067625122468, 4254.85108021224, 4883.706977581356, 4962.230854217602, 4971.726555039435, 4983.700977941263, 4994.65144411007, 1276.8786965238287, 1290.4644572502307, 1292.868739852629, 1302.863199364072, 1303.641498587896, 823.6417158536055, 841.7348535211389, 874.6326542852017, 903.575319599787, 905.7780843693338, 4386.026288170272, 4394.473177922707, 4399.14216727735, 4432.357308190294, 4438.7114837535455, 5088.1350170471105, 5092.567131793765, 5100.923486147711, 5113.360829896263, 5117.232415137759, 4195.181939521825, 4395.670324725658, 4408.404865343202, 4409.625181859577, 4416.173648864729, 2732.344237383014, 2732.9863350683117, 2747.6840163381066, 2765.875535600903, 2769.806113572071, 4765.618750499952, 4782.426108866958, 4796.832110876103, 4822.734749588736, 4824.0, 5036.748162591855, 5174.586033117342, 5198.506141916512, 5214.947850521522, 5222.3733152022005, 4700.929486057712, 4756.262779269219, 4778.522147785263, 4792.2811578262845, 4813.78337974799, 5080.415752188398, 5091.796328146833, 5103.260027296095, 5116.309298244838, 5116.692998420107, 4744.976275118603, 4967.304577359245, 4978.477259887804, 4983.0, 5004.274380214775, 4782.784774685217, 4784.40194975628, 4793.976030119967, 4800.135975524299, 4803.847076701636, 3678.282734866675, 3682.5765037021088, 3682.6869716074434, 3688.4467329899658, 3694.8522059117336, 4813.374261346003, 5072.695638261716, 5078.746062696924, 5102.897942041212, 5107.88022970478, 4916.992016636509, 4922.261660750916, 4926.975365123151, 4943.505649435027, 4950.217921548167, 4911.803527858846, 4920.065187614342, 4939.53074457926, 4955.35580374549, 4960.916415105737, 4592.862214133581, 4782.545658162469, 4801.423829140525, 4865.659403841697, 4889.188716487963, 4856.927146092882, 4863.927041094457, 4952.678075925053, 4982.576480999156, 4994.076095922266, 4846.18268149444, 4850.878728031827, 4860.756962151949, 4863.610911127172, 4865.783554111472], "value": 3758.3204215069686, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.9098230756538, 634.3339493531794, 677.5088061155662, 698.9825254368643, 711.5197241861742, 11799.469023893924, 12756.55352062678, 13016.349182540858, 13121.147125436864, 13138.408771605276, 12254.387280635954, 12941.48234070636, 12988.350582470886, 12990.74018519629, 13001.934990325059, 624.5940138909722, 765.6401491299108, 771.845630873826, 774.6862520679134, 791.8614242507567, 790.7192946503994, 792.7700966719644, 794.9244821741926, 795.2008231727107, 796.0725754496005, 836.4228682209256, 836.5608055770708, 836.9246767790897, 837.1084794693662, 838.1283465196188, 643.3116565275158, 801.7394346837301, 802.9558374289412, 807.3500831830374, 832.379876991642, 605.3401792046647, 606.1029676079427, 606.4178388746808, 606.4360145065087, 606.7057477123592, 12897.87102128976, 12916.289604071771, 12938.288394138319, 12947.223166610034, 12955.740885182338, 12427.689307767288, 12771.808422873664, 12885.484580616763, 12914.483420663162, 12938.547150849769, 10740.355578665305, 10927.945360273148, 11140.220184587082, 11304.547818087267, 11307.0, 4092.9181416371803, 4161.146964872194, 4167.541570427251, 4270.295401258789, 4380.408644832971, 56608.43391566073, 56944.0, 57341.713291433276, 58075.419245807425, 58937.41062589362, 9999.35004224723, 10134.189264858793, 10212.131968782736, 10242.436665983443, 10267.024632659886, 17871.73192402115, 17902.373416930604, 17909.462716118538, 17989.280428782964, 18010.099495025457, 6277.0, 6348.77779277723, 6427.260865000491, 6438.549301548846, 6444.903326450107, 3533.363994481018, 3631.6368363164, 3648.5074514940143, 3651.598324184338, 3698.1863989922176, 2614.542455070355, 2710.471458065698, 2713.4844379567817, 2716.7011628720825, 2718.5786203138546, 490.9140900342426, 517.1467079319078, 518.5100080424038, 524.1718085425019, 558.2101326622865, 521.9008388406266, 553.1067326268048, 554.4981791478718, 558.0, 571.2259887851901, 8071.192880711882, 8380.958095209486, 8460.915390846136, 8577.099404562556, 8625.439346442461, 561.7079118858171, 596.2010905386802, 606.1423086332878, 606.4663096475074, 609.9329073801878, 3797.430385442206, 3900.0, 3922.9019274517796, 4007.6192761687594, 4010.8195131219163, 93217.0, 99792.0, 102844.0, 104020.0, 104472.47763761284, 53361.73319133457, 72493.2750672497, 77878.61060694774, 85972.57013715016, 90178.0, 77224.0, 79665.0, 79813.60093199497, 79882.0, 80028.5998570015, 7581.317681408479, 7704.768856934301, 8085.676572937016, 8099.0, 8235.670573177005, 37885.81057094697, 38229.42655860109, 38477.80761096177, 48341.27488087752, 48969.2654610174, 40180.31286072472, 43618.0, 53116.46883531115, 60568.69715651393, 61977.0, 10970.945145274223, 11068.335899846035, 11219.0, 11298.43507824589, 11413.771724565628, 12008.099392545419, 12732.554360597334, 13130.277834719182, 13487.932560337136, 13588.524401645895, 12019.098567607289, 12023.4589443477, 12112.75774484523, 12161.817572736592, 12281.570145044881, 11848.940755296513, 12062.0, 12127.332996685267, 12363.75272494563, 12541.74916501683, 11725.530978760755, 12557.971122320769, 12679.429425676051, 12688.936555317165, 12699.682507937376, 9955.253355998184, 9997.800043999225, 10000.000000000115, 10095.495225238856, 10394.948025259826, 9035.27717782589, 9552.283578731762, 9677.854832177663, 10546.209034322303, 10593.470326483799], "value": 6525.047699174894, "unit": "score"}], "name": "dromaeo_css", "value": 6262.035741350898, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 108.0, 113.0, 116.0, 113.0, 113.0, 112.0, 114.0, 115.0, 113.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 136.0, 184.0, 134.0, 163.0, 163.0, 135.0, 192.0, 130.0], "value": 151.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 161.0, 162.0, 163.0, 162.0, 164.0, 162.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 74.0, 76.0, 113.0, 75.0, 77.0, 75.0, 75.0, 98.0, 76.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 114.0, 87.0, 87.0, 86.0, 120.0, 87.0, 86.0, 131.0], "value": 97.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0, 64.0, 63.0, 77.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 64.0, 65.0, 67.0, 66.0, 66.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 83.0, 85.0, 86.0, 85.0, 85.0, 91.0, 122.0, 90.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 134.0, 133.0, 135.0, 131.0, 141.0, 136.0, 129.0, 144.0, 134.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 169.0, 174.0, 166.0, 171.0, 168.0, 168.0, 170.0, 175.0, 169.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 67.0, 67.0, 75.0, 68.0, 69.0, 68.0, 66.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1560.1, "alertThreshold": 2.0}]} 04:40:12 INFO - Return code: 0 04:40:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:40:12 ERROR - # TBPL SUCCESS # 04:40:12 INFO - Running post-action listener: _resource_record_post_action 04:40:12 INFO - ##### 04:40:12 INFO - ##### Finished run-tests step (success) 04:40:12 INFO - ##### 04:40:12 INFO - Running post-run listener: _resource_record_post_run 04:40:12 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 525221888; Read time: 8; Write time: 419448 04:40:12 INFO - TinderboxPrint: CPU usage
13.1% 04:40:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 04:40:12 INFO - TinderboxPrint: I/O write bytes / time
525,221,888 / 419,448 04:40:12 INFO - TinderboxPrint: CPU idle
8,317.4 (86.8%) 04:40:12 INFO - TinderboxPrint: CPU user
1,213.6 (12.7%) 04:40:12 INFO - TinderboxPrint: Swap in / out
0 / 0 04:40:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237895680; Read time: 0; Write time: 217780 04:40:12 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287326208; Read time: 8; Write time: 201668 04:40:13 INFO - Running post-run listener: _upload_blobber_files 04:40:13 INFO - Blob upload gear active. 04:40:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:13 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 04:40:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:40:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:40:13 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:40:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:40:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:16 INFO - (blobuploader) - INFO - Done attempting. 04:40:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:40:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:40:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:17 INFO - (blobuploader) - INFO - Done attempting. 04:40:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:40:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:18 INFO - (blobuploader) - INFO - Done attempting. 04:40:18 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:18 INFO - Return code: 0 04:40:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d53fea08271d150196b8876de5ece75dab45729c816a106ee3eade815342c0108c53bceffe353e37080f157c5eceff37ee765b55140ebda8feb7162aece9d9be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa65e4ded49af99d9838522fde07500aa4aa2e2a22d0fb6c83421c7973b0cb046b952b7f3dc02de8b1a5d0ab5c6b6702dcbcd130858fc7873c333c23a728362e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cf33228094958a6b500be9798c105a1369b7334bb76288f5dd140a57e5a4d6c6f3396014ce5305db0367cbd55e619b6153a3512e1c23606858461dd81338afd"} 04:40:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:18 INFO - Contents: 04:40:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d53fea08271d150196b8876de5ece75dab45729c816a106ee3eade815342c0108c53bceffe353e37080f157c5eceff37ee765b55140ebda8feb7162aece9d9be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa65e4ded49af99d9838522fde07500aa4aa2e2a22d0fb6c83421c7973b0cb046b952b7f3dc02de8b1a5d0ab5c6b6702dcbcd130858fc7873c333c23a728362e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cf33228094958a6b500be9798c105a1369b7334bb76288f5dd140a57e5a4d6c6f3396014ce5305db0367cbd55e619b6153a3512e1c23606858461dd81338afd"} 04:40:18 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:18 INFO - Copying logs to upload dir... 04:40:18 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.135973 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-09 04:40:17.926503) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:17.929935) ========= 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=523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d53fea08271d150196b8876de5ece75dab45729c816a106ee3eade815342c0108c53bceffe353e37080f157c5eceff37ee765b55140ebda8feb7162aece9d9be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa65e4ded49af99d9838522fde07500aa4aa2e2a22d0fb6c83421c7973b0cb046b952b7f3dc02de8b1a5d0ab5c6b6702dcbcd130858fc7873c333c23a728362e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cf33228094958a6b500be9798c105a1369b7334bb76288f5dd140a57e5a4d6c6f3396014ce5305db0367cbd55e619b6153a3512e1c23606858461dd81338afd"} build_url:https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/AjJ90RMJQo6O3lyTD2K0Gw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d53fea08271d150196b8876de5ece75dab45729c816a106ee3eade815342c0108c53bceffe353e37080f157c5eceff37ee765b55140ebda8feb7162aece9d9be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/aa65e4ded49af99d9838522fde07500aa4aa2e2a22d0fb6c83421c7973b0cb046b952b7f3dc02de8b1a5d0ab5c6b6702dcbcd130858fc7873c333c23a728362e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7cf33228094958a6b500be9798c105a1369b7334bb76288f5dd140a57e5a4d6c6f3396014ce5305db0367cbd55e619b6153a3512e1c23606858461dd81338afd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:17.954963) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:17.955293) ========= 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=523ca41ca1e0623de333ad52000001bf-1465470801.404447-1995706808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:18.007867) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:40:18.008179) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:40:18.008493) ========= ========= Total master_lag: 0.13 =========