builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1465471162.96 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.959229) ========= 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.959913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.960186) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.991179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:22.991455) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162 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% 225M=0s 2016-06-09 04:19:23 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088020 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.097131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.097423) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018870 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.148508) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.149042) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-09 04:19:24,049 truncating revision to first 12 chars 2016-06-09 04:19:24,049 Setting DEBUG logging. 2016-06-09 04:19:24,049 attempt 1/10 2016-06-09 04:19:24,049 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,370 unpacking tar archive at: fx-team-ac4dd317658c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.662931 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.826039) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.826376) ========= script_repo_revision: ac4dd317658c8f838e5a5975baf09e739b415ba3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.826823) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.827115) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-09 04:19:23.836565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 04:19:23.836959) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162 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-e10s --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-e10s', 04:19:24 INFO - 'system_bits': '32', 04:19:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:24 INFO - 'title': 'talos-linux64-ix-068', 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-e10s", 04:19:25 INFO - "repository": "", 04:19:25 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 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": 1575, 04:19:25 INFO - "slavename": "talos-linux64-ix-068", 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:29 INFO - Downloaded 1361 bytes. 04:19:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:19:29 INFO - Using the following test package requirements: 04:19:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:19:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:19:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'jsshell-linux-x86_64.zip'], 04:19:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:19:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:19:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:19:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:19:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:19:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:19:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:19:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:19:29 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:29 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:29 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:29 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:29 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:29 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:31 INFO - Downloaded 22879579 bytes. 04:19:31 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:31 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:32 INFO - Return code: 0 04:19:32 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:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:32 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:32 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:32 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:32 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:32 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 - 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.talos.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.talos.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.talos.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.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.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.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:36 INFO - Downloaded 10833377 bytes. 04:19:36 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:36 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:37 INFO - Return code: 0 04:19:37 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:37 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:37 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:37 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:37 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:37 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:38 INFO - Downloaded 55434056 bytes. 04:19:38 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:38 INFO - mkdir: /builds/slave/test/properties 04:19:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:38 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:38 INFO - Contents: 04:19:38 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:39 INFO - Running post-action listener: _resource_record_post_action 04:19:39 INFO - Running post-action listener: set_extra_try_arguments 04:19:39 INFO - ##### 04:19:39 INFO - ##### Finished download-and-extract step (success) 04:19:39 INFO - ##### 04:19:39 INFO - ##### 04:19:39 INFO - ##### Running populate-webroot step. 04:19:39 INFO - ##### 04:19:39 INFO - Running pre-action listener: _resource_record_pre_action 04:19:39 INFO - Running main action method: populate_webroot 04:19:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:39 INFO - '--tppagecycles', 04:19:39 INFO - '7'], 04:19:39 INFO - 'tests': ['tsvgm']}}, 04:19:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:19:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['damp', 'tps']}, 04:19:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'tests': ['damp', 'tps']}, 04:19:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['dromaeo_dom']}, 04:19:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['a11yr', 04:19:39 INFO - 'ts_paint', 04:19:39 INFO - 'tpaint', 04:19:39 INFO - 'sessionrestore', 04:19:39 INFO - 'sessionrestore_no_auto_restore', 04:19:39 INFO - 'tabpaint']}, 04:19:39 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:39 INFO - 'ts_paint', 04:19:39 INFO - 'tpaint', 04:19:39 INFO - 'sessionrestore', 04:19:39 INFO - 'sessionrestore_no_auto_restore', 04:19:39 INFO - 'tabpaint']}, 04:19:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:19:39 INFO - 'ts_paint', 04:19:39 INFO - 'tpaint', 04:19:39 INFO - 'sessionrestore', 04:19:39 INFO - 'sessionrestore_no_auto_restore', 04:19:39 INFO - 'tabpaint']}, 04:19:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:19:39 INFO - 'ts_paint', 04:19:39 INFO - 'tpaint', 04:19:39 INFO - 'sessionrestore', 04:19:39 INFO - 'sessionrestore_no_auto_restore', 04:19:39 INFO - 'tabpaint']}, 04:19:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['a11yr', 04:19:39 INFO - 'ts_paint', 04:19:39 INFO - 'tpaint', 04:19:39 INFO - 'sessionrestore', 04:19:39 INFO - 'sessionrestore_no_auto_restore', 04:19:39 INFO - 'tabpaint']}, 04:19:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['a11yr', 04:19:39 INFO - 'ts_paint', 04:19:39 INFO - 'tpaint', 04:19:39 INFO - 'sessionrestore', 04:19:39 INFO - 'sessionrestore_no_auto_restore', 04:19:39 INFO - 'tabpaint']}, 04:19:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['tsvgx', 04:19:39 INFO - 'tsvgr_opacity', 04:19:39 INFO - 'tart', 04:19:39 INFO - 'tscrollx', 04:19:39 INFO - 'cart']}, 04:19:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:39 INFO - 'tsvgr_opacity', 04:19:39 INFO - 'tart', 04:19:39 INFO - 'tscrollx', 04:19:39 INFO - 'cart']}, 04:19:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'talos_options': ['--disable-e10s'], 04:19:39 INFO - 'tests': ['tp5o']}, 04:19:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'tests': ['tp5o']}, 04:19:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'talos_options': ['--disable-e10s', 04:19:39 INFO - '--xperf_path', 04:19:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:39 INFO - 'tests': ['tp5n']}, 04:19:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:19:39 INFO - 'talos_options': ['--xperf_path', 04:19:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:39 INFO - 'tests': ['tp5n']}}, 04:19:39 INFO - 'talos.zip': {'path': '', 04:19:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:39 INFO - Running post-action listener: _resource_record_post_action 04:19:39 INFO - ##### 04:19:39 INFO - ##### Finished populate-webroot step (success) 04:19:39 INFO - ##### 04:19:39 INFO - ##### 04:19:39 INFO - ##### Running create-virtualenv step. 04:19:39 INFO - ##### 04:19:39 INFO - Running pre-action listener: _resource_record_pre_action 04:19:39 INFO - Running main action method: create_virtualenv 04:19:39 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:39 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:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:39 INFO - Using real prefix '/usr' 04:19:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:41 INFO - Installing pip.................done. 04:19:41 INFO - Return code: 0 04:19:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:19:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:19:41 INFO - Using env: {'DISPLAY': ':0', 04:19:41 INFO - 'HOME': '/home/cltbld', 04:19:41 INFO - 'LANG': 'en_US.UTF-8', 04:19:41 INFO - 'LANGUAGE': 'en_US:en', 04:19:41 INFO - 'LOGNAME': 'cltbld', 04:19:41 INFO - 'MAIL': '/var/mail/cltbld', 04:19:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:41 INFO - 'MOZ_NO_REMOTE': '1', 04:19:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:41 INFO - 'NO_EM_RESTART': '1', 04:19:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:41 INFO - 'PWD': '/builds/slave/test', 04:19:41 INFO - 'SHELL': '/bin/bash', 04:19:41 INFO - 'SHLVL': '1', 04:19:41 INFO - 'TERM': 'linux', 04:19:41 INFO - 'TMOUT': '86400', 04:19:41 INFO - 'USER': 'cltbld', 04:19:41 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:19:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:41 INFO - '_': '/tools/buildbot/bin/python'} 04:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:42 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:42 INFO - Cleaning up... 04:19:42 INFO - Return code: 0 04:19:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:42 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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:42 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:42 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:42 INFO - Using env: {'DISPLAY': ':0', 04:19:42 INFO - 'HOME': '/home/cltbld', 04:19:42 INFO - 'LANG': 'en_US.UTF-8', 04:19:42 INFO - 'LANGUAGE': 'en_US:en', 04:19:42 INFO - 'LOGNAME': 'cltbld', 04:19:42 INFO - 'MAIL': '/var/mail/cltbld', 04:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:42 INFO - 'MOZ_NO_REMOTE': '1', 04:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:42 INFO - 'NO_EM_RESTART': '1', 04:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:42 INFO - 'PWD': '/builds/slave/test', 04:19:42 INFO - 'SHELL': '/bin/bash', 04:19:42 INFO - 'SHLVL': '1', 04:19:42 INFO - 'TERM': 'linux', 04:19:42 INFO - 'TMOUT': '86400', 04:19:42 INFO - 'USER': 'cltbld', 04:19:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:42 INFO - '_': '/tools/buildbot/bin/python'} 04:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:42 INFO - Downloading/unpacking psutil>=3.1.1 04:19:42 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:42 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:42 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:42 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:42 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:42 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:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:44 INFO - Installing collected packages: psutil 04:19:44 INFO - Running setup.py install for psutil 04:19:44 INFO - building 'psutil._psutil_linux' extension 04:19:44 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:44 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:44 INFO - building 'psutil._psutil_posix' extension 04:19:44 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:44 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:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:44 INFO - Successfully installed psutil 04:19:44 INFO - Cleaning up... 04:19:44 INFO - Return code: 0 04:19:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:44 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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:44 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:44 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:44 INFO - Using env: {'DISPLAY': ':0', 04:19:44 INFO - 'HOME': '/home/cltbld', 04:19:44 INFO - 'LANG': 'en_US.UTF-8', 04:19:44 INFO - 'LANGUAGE': 'en_US:en', 04:19:44 INFO - 'LOGNAME': 'cltbld', 04:19:44 INFO - 'MAIL': '/var/mail/cltbld', 04:19:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:44 INFO - 'MOZ_NO_REMOTE': '1', 04:19:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:44 INFO - 'NO_EM_RESTART': '1', 04:19:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:44 INFO - 'PWD': '/builds/slave/test', 04:19:44 INFO - 'SHELL': '/bin/bash', 04:19:44 INFO - 'SHLVL': '1', 04:19:44 INFO - 'TERM': 'linux', 04:19:44 INFO - 'TMOUT': '86400', 04:19:44 INFO - 'USER': 'cltbld', 04:19:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:19:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:44 INFO - '_': '/tools/buildbot/bin/python'} 04:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:19:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:19:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:47 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:47 INFO - Installing collected packages: mozsystemmonitor 04:19:47 INFO - Running setup.py install for mozsystemmonitor 04:19:47 INFO - Successfully installed mozsystemmonitor 04:19:47 INFO - Cleaning up... 04:19:47 INFO - Return code: 0 04:19:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:19:47 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:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:47 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:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:47 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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 04:19:47 INFO - 'HOME': '/home/cltbld', 04:19:47 INFO - 'LANG': 'en_US.UTF-8', 04:19:47 INFO - 'LANGUAGE': 'en_US:en', 04:19:47 INFO - 'LOGNAME': 'cltbld', 04:19:47 INFO - 'MAIL': '/var/mail/cltbld', 04:19:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:47 INFO - 'MOZ_NO_REMOTE': '1', 04:19:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:47 INFO - 'NO_EM_RESTART': '1', 04:19:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:47 INFO - 'PWD': '/builds/slave/test', 04:19:47 INFO - 'SHELL': '/bin/bash', 04:19:47 INFO - 'SHLVL': '1', 04:19:47 INFO - 'TERM': 'linux', 04:19:47 INFO - 'TMOUT': '86400', 04:19:47 INFO - 'USER': 'cltbld', 04:19:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:19:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:47 INFO - '_': '/tools/buildbot/bin/python'} 04:19:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:47 INFO - Downloading/unpacking jsonschema==2.5.1 04:19:47 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:47 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:47 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:47 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:47 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:47 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:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:19:49 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:49 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:49 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:49 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:49 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:49 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:49 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:49 INFO - warning: no files found matching '*.txt' 04:19:49 INFO - no previously-included directories found matching 'build' 04:19:49 INFO - no previously-included directories found matching 'dist' 04:19:49 INFO - no previously-included directories found matching '.git*' 04:19:49 INFO - Installing collected packages: jsonschema, functools32 04:19:49 INFO - Running setup.py install for functools32 04:19:49 INFO - warning: no files found matching '*.txt' 04:19:49 INFO - no previously-included directories found matching 'build' 04:19:49 INFO - no previously-included directories found matching 'dist' 04:19:49 INFO - no previously-included directories found matching '.git*' 04:19:49 INFO - Successfully installed jsonschema functools32 04:19:49 INFO - Cleaning up... 04:19:49 INFO - Return code: 0 04:19:49 INFO - Installing blobuploader==1.2.4 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', '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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 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 - Downloading/unpacking blobuploader==1.2.4 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:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:19:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:19:52 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:52 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 - 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:52 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:52 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:52 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/requests/setup.py) egg_info for package requests 04:19:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:19:52 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:52 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 - 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:52 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:52 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:52 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 - Downloading docopt-0.6.1.tar.gz 04:19:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:19:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:19:52 INFO - Running setup.py install for blobuploader 04:19:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:19:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:19:52 INFO - Running setup.py install for requests 04:19:53 INFO - Running setup.py install for docopt 04:19:53 INFO - Successfully installed blobuploader requests docopt 04:19:53 INFO - Cleaning up... 04:19:53 INFO - Return code: 0 04:19:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:53 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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:53 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:19:53 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:19:53 INFO - Using env: {'DISPLAY': ':0', 04:19:53 INFO - 'HOME': '/home/cltbld', 04:19:53 INFO - 'LANG': 'en_US.UTF-8', 04:19:53 INFO - 'LANGUAGE': 'en_US:en', 04:19:53 INFO - 'LOGNAME': 'cltbld', 04:19:53 INFO - 'MAIL': '/var/mail/cltbld', 04:19:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:53 INFO - 'MOZ_NO_REMOTE': '1', 04:19:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:53 INFO - 'NO_EM_RESTART': '1', 04:19:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:53 INFO - 'PWD': '/builds/slave/test', 04:19:53 INFO - 'SHELL': '/bin/bash', 04:19:53 INFO - 'SHLVL': '1', 04:19:53 INFO - 'TERM': 'linux', 04:19:53 INFO - 'TMOUT': '86400', 04:19:53 INFO - 'USER': 'cltbld', 04:19:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:19:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:53 INFO - '_': '/tools/buildbot/bin/python'} 04:19:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:53 INFO - Running setup.py (path:/tmp/pip-_ASvkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:53 INFO - Running setup.py (path:/tmp/pip-P8atjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:53 INFO - Running setup.py (path:/tmp/pip-1hSTbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:53 INFO - Running setup.py (path:/tmp/pip-d1UqQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:53 INFO - Running setup.py (path:/tmp/pip-cxVIE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:54 INFO - Running setup.py (path:/tmp/pip-5gOyL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:54 INFO - Running setup.py (path:/tmp/pip-a2n33f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:54 INFO - Running setup.py (path:/tmp/pip-soQz52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:54 INFO - Running setup.py (path:/tmp/pip-wa3AJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:54 INFO - Running setup.py (path:/tmp/pip-SV_dcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:54 INFO - Running setup.py (path:/tmp/pip-bA0GIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:54 INFO - Running setup.py (path:/tmp/pip-BGbhpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:54 INFO - Running setup.py (path:/tmp/pip-qzG5w3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:54 INFO - Running setup.py (path:/tmp/pip-_hRVq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:54 INFO - Running setup.py (path:/tmp/pip-8E4WC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:54 INFO - Running setup.py (path:/tmp/pip-XBOqSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:54 INFO - Running setup.py (path:/tmp/pip-GhBUNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:19:54 INFO - Running setup.py install for manifestparser 04:19:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Running setup.py install for mozcrash 04:19:55 INFO - Running setup.py install for mozdebug 04:19:55 INFO - Running setup.py install for mozdevice 04:19:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Running setup.py install for mozfile 04:19:55 INFO - Running setup.py install for mozhttpd 04:19:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Running setup.py install for mozinfo 04:19:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Running setup.py install for mozInstall 04:19:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Running setup.py install for mozleak 04:19:55 INFO - Running setup.py install for mozlog 04:19:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:19:55 INFO - Running setup.py install for moznetwork 04:19:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:19:56 INFO - Running setup.py install for mozprocess 04:19:56 INFO - Running setup.py install for mozprofile 04:19:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:19:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:19:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:19:56 INFO - Running setup.py install for mozrunner 04:19:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:19:56 INFO - Running setup.py install for mozscreenshot 04:19:56 INFO - Running setup.py install for moztest 04:19:56 INFO - Running setup.py install for mozversion 04:19:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:19:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:19:56 INFO - Cleaning up... 04:19:56 INFO - Return code: 0 04:19:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:19:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:19:56 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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:56 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:19:56 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:19:56 INFO - Using env: {'DISPLAY': ':0', 04:19:56 INFO - 'HOME': '/home/cltbld', 04:19:56 INFO - 'LANG': 'en_US.UTF-8', 04:19:56 INFO - 'LANGUAGE': 'en_US:en', 04:19:56 INFO - 'LOGNAME': 'cltbld', 04:19:56 INFO - 'MAIL': '/var/mail/cltbld', 04:19:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:56 INFO - 'MOZ_NO_REMOTE': '1', 04:19:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:56 INFO - 'NO_EM_RESTART': '1', 04:19:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:56 INFO - 'PWD': '/builds/slave/test', 04:19:56 INFO - 'SHELL': '/bin/bash', 04:19:56 INFO - 'SHLVL': '1', 04:19:56 INFO - 'TERM': 'linux', 04:19:56 INFO - 'TMOUT': '86400', 04:19:56 INFO - 'USER': 'cltbld', 04:19:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:19:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:56 INFO - '_': '/tools/buildbot/bin/python'} 04:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:56 INFO - Running setup.py (path:/tmp/pip-R8Rs_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:57 INFO - Running setup.py (path:/tmp/pip-r94C9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:57 INFO - Running setup.py (path:/tmp/pip-tm0ykX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:57 INFO - Running setup.py (path:/tmp/pip-bg4fUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:57 INFO - Running setup.py (path:/tmp/pip-VR4vDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:57 INFO - Running setup.py (path:/tmp/pip-C1tsd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:57 INFO - Running setup.py (path:/tmp/pip-ZKXan3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:57 INFO - Running setup.py (path:/tmp/pip-SWSviL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:57 INFO - Running setup.py (path:/tmp/pip-rpJq8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:57 INFO - Running setup.py (path:/tmp/pip-Dhs_At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:57 INFO - Running setup.py (path:/tmp/pip-cXlN0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:57 INFO - Running setup.py (path:/tmp/pip-1OWXke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:57 INFO - Running setup.py (path:/tmp/pip-Q1KRyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:57 INFO - Running setup.py (path:/tmp/pip-39JAEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:57 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:19:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:57 INFO - Running setup.py (path:/tmp/pip-KGCHaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:58 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:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:58 INFO - Running setup.py (path:/tmp/pip-3WgR0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:58 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:19:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:58 INFO - Running setup.py (path:/tmp/pip-qBQ8AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:58 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:19:58 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:19:58 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:19:58 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:19:58 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:19:58 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:19:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:19:58 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:58 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:58 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:58 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:58 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:58 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 blessings-1.6.tar.gz 04:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:00 INFO - Installing collected packages: blessings 04:20:00 INFO - Running setup.py install for blessings 04:20:00 INFO - Successfully installed blessings 04:20:00 INFO - Cleaning up... 04:20:00 INFO - Return code: 0 04:20:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:00 INFO - Reading from file tmpfile_stdout 04:20:00 INFO - Current package versions: 04:20:00 INFO - argparse == 1.2.1 04:20:00 INFO - blessings == 1.6 04:20:00 INFO - blobuploader == 1.2.4 04:20:00 INFO - docopt == 0.6.1 04:20:00 INFO - functools32 == 3.2.3-2 04:20:00 INFO - jsonschema == 2.5.1 04:20:00 INFO - manifestparser == 1.1 04:20:00 INFO - mozInstall == 1.12 04:20:00 INFO - mozcrash == 0.17 04:20:00 INFO - mozdebug == 0.1 04:20:00 INFO - mozdevice == 0.48 04:20:00 INFO - mozfile == 1.2 04:20:00 INFO - mozhttpd == 0.7 04:20:00 INFO - mozinfo == 0.9 04:20:00 INFO - mozleak == 0.1 04:20:00 INFO - mozlog == 3.2 04:20:00 INFO - moznetwork == 0.27 04:20:00 INFO - mozprocess == 0.22 04:20:00 INFO - mozprofile == 0.28 04:20:00 INFO - mozrunner == 6.11 04:20:00 INFO - mozscreenshot == 0.1 04:20:00 INFO - mozsystemmonitor == 0.3 04:20:00 INFO - moztest == 0.7 04:20:00 INFO - mozversion == 1.4 04:20:00 INFO - psutil == 3.1.1 04:20:00 INFO - requests == 1.2.3 04:20:00 INFO - wsgiref == 0.1.2 04:20:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 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 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:00 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:00 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:00 INFO - Using env: {'DISPLAY': ':0', 04:20:00 INFO - 'HOME': '/home/cltbld', 04:20:00 INFO - 'LANG': 'en_US.UTF-8', 04:20:00 INFO - 'LANGUAGE': 'en_US:en', 04:20:00 INFO - 'LOGNAME': 'cltbld', 04:20:00 INFO - 'MAIL': '/var/mail/cltbld', 04:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:00 INFO - 'MOZ_NO_REMOTE': '1', 04:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:00 INFO - 'NO_EM_RESTART': '1', 04:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:00 INFO - 'PWD': '/builds/slave/test', 04:20:00 INFO - 'SHELL': '/bin/bash', 04:20:00 INFO - 'SHLVL': '1', 04:20:00 INFO - 'TERM': 'linux', 04:20:00 INFO - 'TMOUT': '86400', 04:20:00 INFO - 'USER': 'cltbld', 04:20:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:00 INFO - '_': '/tools/buildbot/bin/python'} 04:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 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:00 INFO - Cleaning up... 04:20:00 INFO - Return code: 0 04:20:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:20:00 INFO - Using env: {'DISPLAY': ':0', 04:20:00 INFO - 'HOME': '/home/cltbld', 04:20:00 INFO - 'LANG': 'en_US.UTF-8', 04:20:00 INFO - 'LANGUAGE': 'en_US:en', 04:20:00 INFO - 'LOGNAME': 'cltbld', 04:20:00 INFO - 'MAIL': '/var/mail/cltbld', 04:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:00 INFO - 'MOZ_NO_REMOTE': '1', 04:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:00 INFO - 'NO_EM_RESTART': '1', 04:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:00 INFO - 'PWD': '/builds/slave/test', 04:20:00 INFO - 'SHELL': '/bin/bash', 04:20:00 INFO - 'SHLVL': '1', 04:20:00 INFO - 'TERM': 'linux', 04:20:00 INFO - 'TMOUT': '86400', 04:20:00 INFO - 'USER': 'cltbld', 04:20:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:00 INFO - '_': '/tools/buildbot/bin/python'} 04:20:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:00 INFO - Cleaning up... 04:20:00 INFO - Return code: 0 04:20:00 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71f67f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2876350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, '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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', '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:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:20:00 INFO - Using env: {'DISPLAY': ':0', 04:20:00 INFO - 'HOME': '/home/cltbld', 04:20:00 INFO - 'LANG': 'en_US.UTF-8', 04:20:00 INFO - 'LANGUAGE': 'en_US:en', 04:20:00 INFO - 'LOGNAME': 'cltbld', 04:20:00 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': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 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 - Downloading/unpacking flake8 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:20:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:20:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:20:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:20:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:20:03 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:03 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:03 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:03 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:03 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:03 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:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:20:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:03 INFO - no previously-included directories found matching 'docs/_build' 04:20:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:20:03 INFO - Running setup.py install for pep8 04:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:20:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:20:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:20:04 INFO - no previously-included directories found matching 'docs/_build' 04:20:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:20:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:20:04 INFO - Cleaning up... 04:20:04 INFO - Return code: 0 04:20:04 INFO - Running post-action listener: _resource_record_post_action 04:20:04 INFO - Running post-action listener: _start_resource_monitoring 04:20:04 INFO - Starting resource monitoring. 04:20:04 INFO - ##### 04:20:04 INFO - ##### Finished create-virtualenv step (success) 04:20:04 INFO - ##### 04:20:04 INFO - ##### 04:20:04 INFO - ##### Running install step. 04:20:04 INFO - ##### 04:20:04 INFO - Running pre-action listener: _resource_record_pre_action 04:20:04 INFO - Running main action method: install 04:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:04 INFO - Reading from file tmpfile_stdout 04:20:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:04 INFO - Reading from file tmpfile_stdout 04:20:04 INFO - Output received: 04:20:04 INFO - Usage: mozinstall [options] installer 04:20:04 INFO - Options: 04:20:04 INFO - -h, --help show this help message and exit 04:20:04 INFO - -d DEST, --destination=DEST 04:20:04 INFO - Directory to install application into. [default: 04:20:04 INFO - "/builds/slave/test"] 04:20:04 INFO - --app=APP Application being installed. [default: firefox] 04:20:04 INFO - mkdir: /builds/slave/test/build/application 04:20:04 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:04 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:20 INFO - Reading from file tmpfile_stdout 04:20:20 INFO - Output received: 04:20:20 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:20 INFO - Running post-action listener: _resource_record_post_action 04:20:20 INFO - ##### 04:20:20 INFO - ##### Finished install step (success) 04:20:20 INFO - ##### 04:20:20 INFO - ##### 04:20:20 INFO - ##### Running run-tests step. 04:20:20 INFO - ##### 04:20:20 INFO - Running pre-action listener: _resource_record_pre_action 04:20:20 INFO - Running main action method: run_tests 04:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:20 INFO - Python 2.7.3 04:20:20 INFO - Return code: 0 04:20:20 INFO - grabbing minidump binary from tooltool 04:20:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:20:20 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 0x29051c0>, '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 0x29060c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2906550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:20 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:20 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:20 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:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:20 INFO - Return code: 0 04:20:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:20:21 INFO - Return code: 0 04:20:21 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-e10s', '--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-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:20:21 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-e10s --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-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:20:21 INFO - Using env: {'DISPLAY': ':0', 04:20:21 INFO - 'HOME': '/home/cltbld', 04:20:21 INFO - 'LANG': 'en_US.UTF-8', 04:20:21 INFO - 'LANGUAGE': 'en_US:en', 04:20:21 INFO - 'LOGNAME': 'cltbld', 04:20:21 INFO - 'MAIL': '/var/mail/cltbld', 04:20:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:21 INFO - 'MOZ_NO_REMOTE': '1', 04:20:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:21 INFO - 'NO_EM_RESTART': '1', 04:20:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:21 INFO - 'PWD': '/builds/slave/test', 04:20:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:21 INFO - 'SHELL': '/bin/bash', 04:20:21 INFO - 'SHLVL': '1', 04:20:21 INFO - 'TERM': 'linux', 04:20:21 INFO - 'TMOUT': '86400', 04:20:21 INFO - 'USER': 'cltbld', 04:20:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162', 04:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:21 INFO - '_': '/tools/buildbot/bin/python'} 04:20:21 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-e10s', '--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-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:20:21 INFO - mozversion application_buildid: 20160609031429 04:20:21 INFO - mozversion application_changeset: ac4dd317658c8f838e5a5975baf09e739b415ba3 04:20:21 INFO - mozversion application_display_name: Nightly 04:20:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:21 INFO - mozversion application_name: Firefox 04:20:21 INFO - mozversion application_remotingname: firefox 04:20:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:20:21 INFO - mozversion application_vendor: Mozilla 04:20:21 INFO - mozversion application_version: 50.0a1 04:20:21 INFO - mozversion platform_buildid: 20160609031429 04:20:21 INFO - mozversion platform_changeset: ac4dd317658c8f838e5a5975baf09e739b415ba3 04:20:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:20:21 INFO - mozversion platform_version: 50.0a1 04:20:21 INFO - using testdate: 1465471221 04:20:21 INFO - actual date: 1465471221 04:20:21 INFO - starting webserver on 'localhost:47360' 04:20:21 INFO - SUITE-START | Running 2 tests 04:20:21 INFO - TEST-START | dromaeo_css 04:20:21 INFO - operating with platform_type : linux_ 04:20:21 INFO - Initialising browser for dromaeo_css test... 04:20:21 INFO - TEST-INFO | started process 22315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpleJN1q/profile http://localhost:47360/getInfo.html) 04:20:26 INFO - PROCESS | 22315 | __metrics Screen width/height:1600/1200 04:20:26 INFO - PROCESS | 22315 | colorDepth:24 04:20:26 INFO - PROCESS | 22315 | Browser inner width/height: 1024/697 04:20:26 INFO - PROCESS | 22315 | __metrics 04:20:27 ERROR - PROCESS | 22315 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:20:28 INFO - TEST-INFO | 22315: exit 0 04:20:28 INFO - Browser initialized. 04:20:28 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:28 INFO - TEST-INFO | started process 22434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpleJN1q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:40 INFO - PROCESS | 22434 | RSS: Main: 185315328 04:20:40 INFO - PROCESS | 22434 | 04:21:30 INFO - PROCESS | 22434 | 1465471290268 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:41 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:47360/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47360/tests/dromaeo/cssquery-ext.html) 04:23:42 INFO - PROCESS | 22434 | RSS: Main: 188727296 04:23:42 INFO - PROCESS | 22434 | 04:26:44 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:47360/tests/dromaeo/cssquery-ext.html (next: http://localhost:47360/tests/dromaeo/cssquery-jquery.html) 04:26:45 INFO - PROCESS | 22434 | RSS: Main: 187170816 04:26:45 INFO - PROCESS | 22434 | 04:29:47 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:47360/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47360/tests/dromaeo/cssquery-mootools.html) 04:29:48 INFO - PROCESS | 22434 | RSS: Main: 188657664 04:29:48 INFO - PROCESS | 22434 | 04:32:49 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:47360/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47360/tests/dromaeo/cssquery-prototype.html) 04:32:50 INFO - PROCESS | 22434 | RSS: Main: 184651776 04:32:50 INFO - PROCESS | 22434 | 04:35:53 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:47360/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47360/tests/dromaeo/cssquery-yui.html) 04:35:53 INFO - PROCESS | 22434 | RSS: Main: 187740160 04:35:53 INFO - PROCESS | 22434 | 04:38:55 INFO - PROCESS | 22434 | Cycle 1(1): loaded http://localhost:47360/tests/dromaeo/cssquery-yui.html (next: http://localhost:47360/tests/dromaeo/cssquery-dojo.html) 04:38:56 INFO - PROCESS | 22434 | RSS: Main: 189206528 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | __start_tp_report 04:38:56 INFO - PROCESS | 22434 | _x_x_mozilla_page_load 04:38:56 INFO - PROCESS | 22434 | _x_x_mozilla_page_load_details 04:38:56 INFO - PROCESS | 22434 | |i|pagename|runs| 04:38:56 INFO - PROCESS | 22434 | |0;dojo.html;2545.3636590852284;2627.5664515354965;2644.65619469469;2672.412069344745;2676.7189445108265;4752.572268495835;4785.377900872886;4851.320815085891;4861.611071114311;4863.440704319004;4692.882677933053;4788.545088216622;4822.855314340567;4854.3446634704305;4855.1018061658615;4384.69307148499;4414.80133393998;4430.047539778947;4509.729416235036;4514.503404625489;4427.313766366218;4441.555844415549;4486.663500237479;4495.43807024122;4547.772611369435;4261.296886013804;4414.757188354639;4422.889427764299;4434.423524941753;4468.75421851798;4455.688101832873;4470.441194850644;4472.664550158718;4477.552244775497;4520.480144783326;4429.247028005247;4448.3549885266775;4458.509563947963;4458.621017213541;4488.663350248712;4755.952440475586;4814.566688997972;4824.445188803297;4826.300186472942;4852.150873597142;5190.92213616796;5217.8173763918085;5233.1365324721755;5237.371515418136;5287;5016.247562865563;5152.381714194284;5237.685738855643;5253.028189784902;5257.684538927639;4812.398450193726;4841.3222148899185;4863;4863.367762190893;4916.827911023097;5278.366596008426;5296.3909150447425;5301.496357845998;5342.2787923630585;5347.491988261109;4837.806487740521;4999.350084488993;5083.822066227664;5110.131277682803;5116.104681680766;5036.11867923112;5126.769295381642;5192.870178245574;5214.165733482625;5256.553192978639;5130.87172820675;5131.409887862944;5152.0211159880255;5156.20078887773;5161.200013997836;5002.474740152232;5038.546530812245;5051.116054690415;5151.871203219949;5198.9740051299505;4395.296752519582;4406.559344065632;4414.713043652217;4446.82212711488;4461.665375096881;3782.678472329828;3788.109794198361;3819.1597848473293;3846.0384903774057;3875.3411919973673;4348.913021739548;4471.575200355961;4485.058137791035;4506.324051392252;4525.230710779176;5191.169412893919;5225.503577160163;5226.085435048852;5241.947580524146;5288.709120998382;4512;4513.819447222074;4520.59314661682;4524.728516289033;4561.133384656904;4554.316852472156;4660.300954856799;4674.883127921829;4709.058188362341;4736.455307639666;4870.220764677634;4875.585575226146;4880.6095512358215;4893.388326459192;4934.3338649282605;5067.493250674903;5229.529342359206;5236.0575096483;5236.18839079928;5295.629305948701;4851.46633870281;4863.756812159307;4882.170031094652;4886;4910.337104490848;5140.537351638371;5145.588352931682;5161.174212126042;5173.560247378864;5208.8437346879655;5035.949640503694;5121.743912804271;5224;5225.268462415341;5229.215617657382;4838.806447742051;4999;5041.0422019816115;5105.2342148678;5122.103631864335;5098.566621837185;5103.617228707936;5105.744712764421;5124.7950081996305;5151.639385242997;4818.975905120452;4995.925061124013;5014.924776128434;5018.573421259234;5029.396472423333;5034.194528875362;5052.292679024866;5075.974620126875;5091.338126043591;5107.259447380184;4975.502449754996;4979.402471703419;4982.825601103944;4989.575886049582;5032.245163225545 04:38:56 INFO - PROCESS | 22434 | |1;ext.html;510.9361329833771;566.9234653321801;571.180356188869;577.3648986115272;582.2198254339185;38997.220055598904;40432.59567404325;40463.19073618526;40492.99999999996;45210.773946130306;39732.602673973255;39906.600933990725;40082.398764018566;40118;40412;7803.921960780404;7932.801679957989;7944.523328600274;7961.1242763295995;7968.920310796905;7808.219178082203;7927.207279272085;7941.364690824749;7949.205079492033;7960.9203907960755;7868.52788832669;7901.48640338379;7953.045634523836;7957.840843183133;7990.7602771916645;7868.921310786876;7892.447528672995;7938.0077490313715;7944.761657150295;7967.521948683039;7903.486273392211;7910.4067194960035;7950.880736788953;7974.3221826144845;7979.760607181794;38183.427248591295;38492;38579.03552411212;38614.22771544554;38643.420348694795;3066.74953387197;3156.779025468218;3182.618085829692;3195.0893995211486;3223.7098661120376;28970.710292897224;29334.266643333875;29351.55972660412;29509.557356639667;29579.260518486994;3005.594244776949;3056.5415187721796;3087.428825667259;3107.1610665120515;3155.021943197593;263130;266391;266858;267596;268379;31566.210844729067;47884.28173577399;47980.280295795594;48285;48477;32112.518312225337;34175.82912085473;34270.828645856614;34321.141971450415;34354;12829.807552886714;12851.614451566467;12862.228266304051;12863.42114604845;12890.548830791065;10932.945335273433;10945.288556243819;10975.341479511255;11037.613683521038;11063.502142403611;7870.763877083697;7887.645055972495;7911.169327220674;7916.287534121957;7919.445638805229;3106.9067927962196;3109.4092122496654;3111.455495288361;3124.094012736281;3167.255694911694;863.6545381847186;880.7225723896952;907.3603109807569;948.9810203796023;1013.476443655293;28052.43895122086;28105.859470702515;28352;28523.89065708712;28858.567121493194;900.9954950225207;968.651285537206;1019.7960407918298;1024.99487502562;1033.6692258477365;14271.500497482539;14680.779788303184;14924.850751492346;14977.176255306063;15090.471833485775;401863;405925;406185;406689;409237;49542.75228623834;50765;50897.745511272944;50957.74521127371;51065.234021489705;1187.0978056676815;1187.4834447015576;1204.5783975608642;1208.383724300613;1214.4595654933646;26271.868640656674;27208.319792005357;27384.178474645792;27560.862195688893;28075.859620701765;40720.38919416152;40875.591244087176;41331.1733765317;41719.58280417157;41743.7912810434;255744;256782;334857;336383;337192;25268.368290792878;25284.747152528977;26249.343766405993;26447.60328595111;27592.862035689694;42226.36660450034;42266;42652.5734742661;43048.35427468653;43345.78327108344;36204;36764.63235367612;36827.631723683495;36955;37573.24853502969;37197.44203836999;37318.25363492769;37466.43800342942;37718.8114059428;37734.62265377421;31330.373392532478;35121.1219719509;36519;37007.25985480329;37260;32560.185995350304;33201.50197747084;33443.498347525296;33808.49287260644;33968.15079623029;25243.368915777253;25669.783174847023;25766.613500797128;25769;26149.34626634273 04:38:56 INFO - PROCESS | 22434 | |2;jquery.html;351.1975136812383;351.2781234562973;360.682599312605;363.0451911472826;370.29274086494786;15747.527574172778;16813.83186168138;17590.29638814446;17823.910880445597;17891.73162402565;15441.768373474408;15623.609409764762;16552.917235413806;16558.254878530464;16593.83406165938;4879.926801097995;5063.544281014708;5102.902875881685;5109.3613298337705;5111.182210846266;3719.572249191337;4986.675866068694;5569.805056823012;5882.264716910387;5889.381614930414;5908.970455147718;5911.142884281777;5915.467607915287;5921.911171332434;5975.850603734898;5706.1440783882545;5830.271216097988;5871.588988770788;5909.349971503131;5912.911306330387;4529.569690879362;5043.747812609355;5068.113080210948;5074.594032477393;5089.770960306795;18270.269189232415;18843.71734423985;19630.803691963185;19689.409317720492;19717.30989415378;1749.8862573932654;1779.973300400495;1812.8821626594229;1826.7168588868747;1985.0967809646577;8338.416310858242;8512.276456501142;8950.194482496541;9019.278457723367;9024.729258122266;1634.6403791165924;1650.5460998225465;1705.5821323775754;1734.6877562038828;1789.5347209725435;69008;71078.64460677664;71231.64384178098;71925.64037179781;72038;9792.804143917225;9907.811062672381;9999.450030248407;10285.177185825116;10835.241533092765;13689.657758556115;13812.516561920285;13902.930485347508;13915.373808178656;13951.232682202373;7063.1524217094275;7084.468664850054;7160.606166660779;7174.748883789147;7213.278672132745;6560.278369379364;6562.573432726953;6626.271110177877;6678.131842860397;6770.898436523456;4206.47419072616;4245.469316335458;4263.189993901149;4301.612854843017;4381.9123617527475;1652.6777278430832;1658.209134135131;1817.7000794868698;1848.1867978089597;1898.4399602117408;759.9620018999028;826.2852632472868;887.174927317588;901.5942825728448;962.4033099478369;16160.676786464204;16449.588760281087;16490.34038638465;16521.91739041321;16858;851.714675583674;883.7481317824389;905.5608030105394;907.3920473282784;940.6707652321633;9189.954050229706;9398.778158839445;9402.43585384879;9448.811023779623;10267.589296428208;397948;407383;416798;423804;426653;80084.59957700175;80371;81414;81641;84451;931.6878845586805;949.378157306965;950.4249928793118;958.6309270930742;962.3359881681617;15645.530634080997;15721.292541835415;15808.60478488047;15996.920015399848;16015.519534413987;36144.45783313305;36529.81735091307;36776.08059798527;37581.24837503289;37794.81102594469;49036.2644560339;49399.75300123476;50179.24731129109;50511.24233136579;50954.74522627363;7628.923710762821;7763.650635721293;7782.92217077822;7882.605869706377;7990.400719946144;6742.9662851685425;9896.802063958536;11069.833952490559;12162.331071791137;12413.317267550372;9558.426494410358;9685.9031409685;9728.221742260745;9926.751831204278;10376.221783366127;10126.341787783771;10139.89860101419;10289.588416463557;10365.481725913825;10371.58513659445;8361.038480574813;9439.622415103318;9962.203023758228;10294.845577316497;10405.06354428105;7766.145723970471;7820;7877.803054923673;7888.684452621831;7986.321162701235;10015.899841001497;10603.840942386025;10735.463226838783;10917;10966.780664386828 04:38:56 INFO - PROCESS | 22434 | |3;mootools.html;1378.6070969773616;1403.8034675145477;1460.7297649934762;1657.668466306739;1679.3114822922605;6543.280239173687;7053.224145344008;7144.964275178623;7640.197779233184;7658.92341076589;7084.822879428017;7163.498555101145;7315;7391.815204619874;7392.519486233391;2093.382452176604;2126.6597344424895;2137.9893100534555;2141.4539292480395;2152.257471172443;2091.1426315210765;2105.9368218953455;2152.117631770974;2152.827773778094;2160.1791319298723;2070.130545171024;2096.8846713430753;2098.674705420662;2104.431803413085;2120.226117467121;2094.4135642020183;2105.0632468551576;2120.936371908845;2124.6069477146775;2134.3916983659583;2077.979220207809;2096.308218287961;2103.8422118341186;2105.0316854247067;2107.7365329333834;7481.5885126318035;7538.773836784905;7551.773446796605;7566.319031287156;7574.772756817304;4430.069685366045;4490.461144662661;4529.09418116378;4529.977350113229;4532.954670453286;2721.306066952934;2785.5960885671666;2816.098848368523;2825.110090321542;2867.555528893025;863.197226579281;881.3037700216821;908.3823000359753;911.6490151291734;920.3373571028849;9960.352577082538;10151.64469243573;10173.694789156338;10200.285979981478;10228.74428139295;4009.358502639622;4032.6773858091283;4098.405731168964;4124.092699606082;4124.608162224584;8782.989956155125;8802.911970880337;8818.382713210141;8842.91157088421;8844.955775221082;4414.955850441519;4429.047754732748;4448.266036104072;4467.955320446819;4482.8655140345845;3489.668481494254;3943.684505239574;4063.91872162561;4111.177764447122;4149.958500414958;3572.1426857554;3587.3722098632634;3621.764585301947;3659.9268014639556;3768.9057773555332;1138.248755821154;1151.9136064795173;1170.5610396101463;1171.4435643069644;1181.031554125626;792.1484404265437;800.2237829305565;814.5601375257295;819.2422009641058;837.7277384849948;5036.194208926554;5065;5081.0854046272025;5084.618653600995;5085.923711144335;807.9313258373104;835.6406745099544;871.7515508080294;906.6373450619673;907.7140700679265;3574.285142971416;3617;3658.1037645776423;3691.1141326082084;3777.962220377816;9037.50293733851;9263.25893928484;9350.532473376305;9365.203957663674;9380.812383752287;9154.542272886329;9247.213986811063;9250.352475326663;9312;9324.95337523308;6840.905455127156;7054.92945070553;7078.1860086090755;7083.468739844532;7114.501984861114;5011.899762004667;5109.284700142058;5333.040052790535;5471.261379713687;5492.066348720807;8420.747377578682;8450.112738162405;8473.5339556325;8536.871946920677;8668.089850565852;8015.799605009922;8324.958375208085;8336.833263334578;8530.445521041112;8629.39594228398;5865.501432378125;6152.477039451696;6417.8716425672155;6491.740330386731;6690.13028306317;7273.599952002691;7329.267073292628;7342.48602597813;7344.742933997284;7357.411407087528;6547.181602299713;6632.568883022588;6735.966320168368;6741.325867413219;6788.185417749902;6489.935100648933;6544.6727663615675;6552.3775241352;6606.273309935807;6663.766768163091;6034.155218269358;6086.360932102242;6099.817005489843;6127.601705889103;6164.352742961924;4192.517860446088;4327.76197309151;4363.934540981824;4376.6717496187275;4383.364412160283;4276.059266961263;4277.98966351663;4343.761093139908;4352.129574085132;4368.410264614236 04:38:56 INFO - PROCESS | 22434 | |4;prototype.html;283.1999601126816;287.8201124297314;293.76352036610524;295.1587974273323;297.7558402110269;4887.486813884544;4965.404151501816;4972.875678108045;5111.642185047043;5147.5109864562855;5023.899522009558;5088.236764485329;5093.719845408501;5105.591552675786;5133.4609865964;3977.6420122188997;3978.5225772907147;3979.8010099495054;3986.242613903349;3989.6010398960016;3892.630200130983;3939.9015024624327;3988.421678856564;3990.7206495545324;3996.5603783583783;3890.513685789276;3907.433422153786;3916.686665066802;3917.373220284755;3930.547986981491;3894.610538946111;3923.293807114718;3931.1720050176664;3935.3900145477496;3940.6453419192126;3478.478228265755;3481.1123163593375;3485.1809824691177;3495.458203978362;3512.227309991798;4895.412550493964;4924.679895806761;4967.478414766434;4989.625778066623;5063.544281014726;4476.776161191928;4517.661175411858;4525.434320709911;4530.909381812378;4547.067851090518;5357.4106848246665;5368.570514358842;5371.623986320959;5385.21914322425;5396.487333703292;3458.5330980317585;3641.817909104561;3668;3800.4299355096955;3808.866689665876;5566.693831839288;5571.192177134293;5612.102063669793;5632.732635157057;5643.830685079454;3746.9508537609513;3749.643783840531;3760.9811950940616;3771.245750849841;3776.962230377661;3594.982025089858;3779.281936432069;3798.734088613826;3804.5624753153743;3823.6176382362096;4316.69783115179;4324.870253892388;4335.328024156261;4369.650427965755;4376;5231.346081739783;5251.238570407269;5271.736413179326;5284;5306.204069389622;1203.8194270859267;1271.4469205895466;1309.2013871538354;1310.4561606933207;1311.252586025975;809.7854068671807;813.4305985809957;826.8387664405383;836.4145098431122;839.3788596438592;4091.365838295069;4126.401671757579;4142.420061191436;4170.311024035271;4212.705110642226;4673.976630116827;4693.22561777303;4749.881252968704;4756.904861902743;4757.381540399795;4087.6525495332635;4131.855385061569;4169.499660040815;4214.768187749703;4223.767692776865;2620.2663254288827;2703.8783254753585;2941.6027386991436;2945.39619378027;2954.1875984104545;5116.872078198075;5124.9743751281;5132.1788513838355;5162.6902385856965;5167.793288268427;5399.6490228135835;5605.859853503695;5619.185218143346;5646.689432081275;5646.915296270559;5132.589392848563;5153;5177;5188.662736922088;5197.766100525486;5523.834284971457;5527.309086364205;5539.141433077718;5564.972175139098;5566.942280966603;5239.895202096013;5314.5482633975;5403.9459605403445;5433.728313584384;5459.945400546103;5187.766550505161;5193.454687257784;5204.063268611686;5207.583393328448;5214;3757.8308976096687;3799.297130030953;3799.506064211635;3806.1626442182674;3807.428885667172;5293.841184764463;5332.946670533245;5332.963538932534;5541.639793413416;5563.970665426909;5336.532453575298;5358.4105748366865;5393.730313484231;5400.729963501888;5455.3453585568395;5369.436209197978;5373.946260537345;5408.215808707637;5410.620291825559;5418.7783008966135;5111.309973153577;5193.76628051731;5263.973680131728;5264.842054738364;5316.282301889196;5334.199870019528;5358.356997160366;5361;5383.380911195262;5388.2725832012175;5270.973645131749;5278.788848446173;5301.310829592128;5303.681779093266;5306.389765177054 04:38:56 INFO - PROCESS | 22434 | |5;yui.html;640.6508452893173;651.1307404614842;662.076403417233;711.2247650061432;750.3659407800409;11764.411779411028;12638.241705497676;12696.80954785679;12703.872961270385;12720;13716.451341946335;14474;14501.274936253198;15002.099874007567;15070.547883563484;619;792.4096548071681;796.5021861336664;797.9800504987393;803.3693550562809;782.35846605783;801.3749275565068;803.9718609848657;806.8063664720484;812.7317985064915;839.1147339556766;843.616154649636;844.2190973349658;845.247729520727;846.4328899637227;828.1925123005082;831.031847897202;832.5753865528563;833.0461621443444;835.4110352201714;609;609.4240942309519;609.5276160975235;610.0513701194641;611.2664802237289;13330.666733331647;13384.330783460788;13394.330283485884;13410.329483525882;13452.192868427926;13622.114562553403;13769.380377883019;13787.724245515134;13957;13960.301984900714;9696.806063878683;9710.854337184948;9711.54517264415;9879.703608891745;10024.248181386425;3391.542141810873;3401.812900290483;3423.1613254752497;3432.5537680101675;3442;59452.10821837676;59555.70222148862;60281;60966.39033609651;61279.999999999556;9675.645409642655;9839.803203936024;10252.487375631188;10254.48727563619;10269.691909242734;20213.292534761214;20330.186792528133;20363.389098327072;20407.285744998855;20424.38726838197;6236.158118654014;6333.65164915934;6569.737210511622;6578.638174900427;6598.241202261801;3606.1165014571075;3607.9278414431565;3661.853525858989;3668.321360548307;3736.252749450121;2725.8637068146513;2841.9857900710776;2844.360018995709;2847.800653954245;2850.4299140171634;502.6983809714142;522.7673685210045;528.4952870009132;529.3837734951219;532.97068661224;433.6639104693887;489.7560197099399;584.7923986984645;606.1998162425556;612.4212619074931;8091.757247282591;8096.51420914747;8176.713815016446;8355.916440835636;8526.445781024213;494.44622023334097;539.7382269599241;587.4243241623233;591.520868096843;596.1594152245314;3850.8844734658005;3881.6894648428056;3924.50943632046;3951.209758048402;3985.4221137934837;85052.57473712716;85289.57355213308;88585;89279;89580;76100;77515;78168;78475.21524784793;79866.20133798703;70632.64683676549;73215.26784732085;73229.26770732224;73277.2672273281;73778;7426.517276377018;7679.69281228767;7758.107817601048;7902.68389264423;7907.090684571348;42607.786961064994;42689.786551067045;42792.57207427886;43407.56592434035;43846.12307753763;37501;40418.39372409475;55022.44977550334;61010;62565.37434625596;10402.895971040192;10518.474076296308;10577.153827693919;10647.733806654896;11014.44927753625;10678;10725.785484290427;10742.462876855969;11001.559937602406;11250;9847.60609575609;9939.204863610748;9977.251706122215;10014.39913605186;10084.848727269244;10342.638007669695;10745.570177192825;11011.394373309546;11104.555817767521;11158.553657853596;9563.665271715456;9570.521473926137;9601.759956000877;9634.614615415305;9944.552495137592;8376.204260595478;8438.789030274293;8523.147685231428;8884.777880553038;8895.2883769297;8519.74440766778;8847.42491738035;8881.511516866634;9118.908810912071;9299.860502092339 04:38:56 INFO - PROCESS | 22434 | __end_tp_report 04:38:56 INFO - PROCESS | 22434 | __start_cc_report 04:38:56 INFO - PROCESS | 22434 | _x_x_mozilla_cycle_collect,376 04:38:56 INFO - PROCESS | 22434 | __end_cc_report 04:38:56 INFO - PROCESS | 22434 | __startTimestamp1465472336201__endTimestamp 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | ------- Summary: start ------- 04:38:56 INFO - PROCESS | 22434 | Number of tests: 6 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | [#0] dojo.html Cycles:165 Average:4787.75 Median:4882.17 stddev:512.50 (10.5%) stddev-sans-first:482.94 04:38:56 INFO - PROCESS | 22434 | Values: 2545.4 2627.6 2644.7 2672.4 2676.7 4752.6 4785.4 4851.3 4861.6 4863.4 4692.9 4788.5 4822.9 4854.3 4855.1 4384.7 4414.8 4430.0 4509.7 4514.5 4427.3 4441.6 4486.7 4495.4 4547.8 4261.3 4414.8 4422.9 4434.4 4468.8 4455.7 4470.4 4472.7 4477.6 4520.5 4429.2 4448.4 4458.5 4458.6 4488.7 4756.0 4814.6 4824.4 4826.3 4852.2 5190.9 5217.8 5233.1 5237.4 5287.0 5016.2 5152.4 5237.7 5253.0 5257.7 4812.4 4841.3 4863.0 4863.4 4916.8 5278.4 5296.4 5301.5 5342.3 5347.5 4837.8 4999.4 5083.8 5110.1 5116.1 5036.1 5126.8 5192.9 5214.2 5256.6 5130.9 5131.4 5152.0 5156.2 5161.2 5002.5 5038.5 5051.1 5151.9 5199.0 4395.3 4406.6 4414.7 4446.8 4461.7 3782.7 3788.1 3819.2 3846.0 3875.3 4348.9 4471.6 4485.1 4506.3 4525.2 5191.2 5225.5 5226.1 5241.9 5288.7 4512.0 4513.8 4520.6 4524.7 4561.1 4554.3 4660.3 4674.9 4709.1 4736.5 4870.2 4875.6 4880.6 4893.4 4934.3 5067.5 5229.5 5236.1 5236.2 5295.6 4851.5 4863.8 4882.2 4886.0 4910.3 5140.5 5145.6 5161.2 5173.6 5208.8 5035.9 5121.7 5224.0 5225.3 5229.2 4838.8 4999.0 5041.0 5105.2 5122.1 5098.6 5103.6 5105.7 5124.8 5151.6 4819.0 4995.9 5014.9 5018.6 5029.4 5034.2 5052.3 5076.0 5091.3 5107.3 4975.5 4979.4 4982.8 4989.6 5032.2 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | [#1] ext.html Cycles:180 Average:46915.82 Median:36891.32 stddev:87573.16 (237.4%) stddev-sans-first:87749.51 04:38:56 INFO - PROCESS | 22434 | Values: 510.9 566.9 571.2 577.4 582.2 38997.2 40432.6 40463.2 40493.0 45210.8 39732.6 39906.6 40082.4 40118.0 40412.0 7803.9 7932.8 7944.5 7961.1 7968.9 7808.2 7927.2 7941.4 7949.2 7960.9 7868.5 7901.5 7953.0 7957.8 7990.8 7868.9 7892.4 7938.0 7944.8 7967.5 7903.5 7910.4 7950.9 7974.3 7979.8 38183.4 38492.0 38579.0 38614.2 38643.4 3066.7 3156.8 3182.6 3195.1 3223.7 28970.7 29334.3 29351.6 29509.6 29579.3 3005.6 3056.5 3087.4 3107.2 3155.0 263130.0 266391.0 266858.0 267596.0 268379.0 31566.2 47884.3 47980.3 48285.0 48477.0 32112.5 34175.8 34270.8 34321.1 34354.0 12829.8 12851.6 12862.2 12863.4 12890.5 10932.9 10945.3 10975.3 11037.6 11063.5 7870.8 7887.6 7911.2 7916.3 7919.4 3106.9 3109.4 3111.5 3124.1 3167.3 863.7 880.7 907.4 949.0 1013.5 28052.4 28105.9 28352.0 28523.9 28858.6 901.0 968.7 1019.8 1025.0 1033.7 14271.5 14680.8 14924.9 14977.2 15090.5 401863.0 405925.0 406185.0 406689.0 409237.0 49542.8 50765.0 50897.7 50957.7 51065.2 1187.1 1187.5 1204.6 1208.4 1214.5 26271.9 27208.3 27384.2 27560.9 28075.9 40720.4 40875.6 41331.2 41719.6 41743.8 255744.0 256782.0 334857.0 336383.0 337192.0 25268.4 25284.7 26249.3 26447.6 27592.9 42226.4 42266.0 42652.6 43048.4 43345.8 36204.0 36764.6 36827.6 36955.0 37573.2 37197.4 37318.3 37466.4 37718.8 37734.6 31330.4 35121.1 36519.0 37007.3 37260.0 32560.2 33201.5 33443.5 33808.5 33968.2 25243.4 25669.8 25766.6 25769.0 26149.3 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | [#2] jquery.html Cycles:180 Average:25038.78 Median:27611.50 stddev:68458.59 (247.9%) stddev-sans-first:68625.54 04:38:56 INFO - PROCESS | 22434 | Values: 351.2 351.3 360.7 363.0 370.3 15747.5 16813.8 17590.3 17823.9 17891.7 15441.8 15623.6 16552.9 16558.3 16593.8 4879.9 5063.5 5102.9 5109.4 5111.2 3719.6 4986.7 5569.8 5882.3 5889.4 5909.0 5911.1 5915.5 5921.9 5975.9 5706.1 5830.3 5871.6 5909.3 5912.9 4529.6 5043.7 5068.1 5074.6 5089.8 18270.3 18843.7 19630.8 19689.4 19717.3 1749.9 1780.0 1812.9 1826.7 1985.1 8338.4 8512.3 8950.2 9019.3 9024.7 1634.6 1650.5 1705.6 1734.7 1789.5 69008.0 71078.6 71231.6 71925.6 72038.0 9792.8 9907.8 9999.5 10285.2 10835.2 13689.7 13812.5 13902.9 13915.4 13951.2 7063.2 7084.5 7160.6 7174.7 7213.3 6560.3 6562.6 6626.3 6678.1 6770.9 4206.5 4245.5 4263.2 4301.6 4381.9 1652.7 1658.2 1817.7 1848.2 1898.4 760.0 826.3 887.2 901.6 962.4 16160.7 16449.6 16490.3 16521.9 16858.0 851.7 883.7 905.6 907.4 940.7 9190.0 9398.8 9402.4 9448.8 10267.6 397948.0 407383.0 416798.0 423804.0 426653.0 80084.6 80371.0 81414.0 81641.0 84451.0 931.7 949.4 950.4 958.6 962.3 15645.5 15721.3 15808.6 15996.9 16015.5 36144.5 36529.8 36776.1 37581.2 37794.8 49036.3 49399.8 50179.2 50511.2 50954.7 7628.9 7763.7 7782.9 7882.6 7990.4 6743.0 9896.8 11069.8 12162.3 12413.3 9558.4 9685.9 9728.2 9926.8 10376.2 10126.3 10139.9 10289.6 10365.5 10371.6 8361.0 9439.6 9962.2 10294.8 10405.1 7766.1 7820.0 7877.8 7888.7 7986.3 10015.9 10603.8 10735.5 10917.0 10966.8 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | [#3] mootools.html Cycles:180 Average:4954.78 Median:5221.16 stddev:2735.09 (52.4%) stddev-sans-first:2729.56 04:38:56 INFO - PROCESS | 22434 | Values: 1378.6 1403.8 1460.7 1657.7 1679.3 6543.3 7053.2 7145.0 7640.2 7658.9 7084.8 7163.5 7315.0 7391.8 7392.5 2093.4 2126.7 2138.0 2141.5 2152.3 2091.1 2105.9 2152.1 2152.8 2160.2 2070.1 2096.9 2098.7 2104.4 2120.2 2094.4 2105.1 2120.9 2124.6 2134.4 2078.0 2096.3 2103.8 2105.0 2107.7 7481.6 7538.8 7551.8 7566.3 7574.8 4430.1 4490.5 4529.1 4530.0 4533.0 2721.3 2785.6 2816.1 2825.1 2867.6 863.2 881.3 908.4 911.6 920.3 9960.4 10151.6 10173.7 10200.3 10228.7 4009.4 4032.7 4098.4 4124.1 4124.6 8783.0 8802.9 8818.4 8842.9 8845.0 4415.0 4429.0 4448.3 4468.0 4482.9 3489.7 3943.7 4063.9 4111.2 4150.0 3572.1 3587.4 3621.8 3659.9 3768.9 1138.2 1151.9 1170.6 1171.4 1181.0 792.1 800.2 814.6 819.2 837.7 5036.2 5065.0 5081.1 5084.6 5085.9 807.9 835.6 871.8 906.6 907.7 3574.3 3617.0 3658.1 3691.1 3778.0 9037.5 9263.3 9350.5 9365.2 9380.8 9154.5 9247.2 9250.4 9312.0 9325.0 6840.9 7054.9 7078.2 7083.5 7114.5 5011.9 5109.3 5333.0 5471.3 5492.1 8420.7 8450.1 8473.5 8536.9 8668.1 8015.8 8325.0 8336.8 8530.4 8629.4 5865.5 6152.5 6417.9 6491.7 6690.1 7273.6 7329.3 7342.5 7344.7 7357.4 6547.2 6632.6 6736.0 6741.3 6788.2 6489.9 6544.7 6552.4 6606.3 6663.8 6034.2 6086.4 6099.8 6127.6 6164.4 4192.5 4327.8 4363.9 4376.7 4383.4 4276.1 4278.0 4343.8 4352.1 4368.4 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | [#4] prototype.html Cycles:180 Average:4356.08 Median:4981.25 stddev:1301.87 (26.1%) stddev-sans-first:1269.12 04:38:56 INFO - PROCESS | 22434 | Values: 283.2 287.8 293.8 295.2 297.8 4887.5 4965.4 4972.9 5111.6 5147.5 5023.9 5088.2 5093.7 5105.6 5133.5 3977.6 3978.5 3979.8 3986.2 3989.6 3892.6 3939.9 3988.4 3990.7 3996.6 3890.5 3907.4 3916.7 3917.4 3930.5 3894.6 3923.3 3931.2 3935.4 3940.6 3478.5 3481.1 3485.2 3495.5 3512.2 4895.4 4924.7 4967.5 4989.6 5063.5 4476.8 4517.7 4525.4 4530.9 4547.1 5357.4 5368.6 5371.6 5385.2 5396.5 3458.5 3641.8 3668.0 3800.4 3808.9 5566.7 5571.2 5612.1 5632.7 5643.8 3747.0 3749.6 3761.0 3771.2 3777.0 3595.0 3779.3 3798.7 3804.6 3823.6 4316.7 4324.9 4335.3 4369.7 4376.0 5231.3 5251.2 5271.7 5284.0 5306.2 1203.8 1271.4 1309.2 1310.5 1311.3 809.8 813.4 826.8 836.4 839.4 4091.4 4126.4 4142.4 4170.3 4212.7 4674.0 4693.2 4749.9 4756.9 4757.4 4087.7 4131.9 4169.5 4214.8 4223.8 2620.3 2703.9 2941.6 2945.4 2954.2 5116.9 5125.0 5132.2 5162.7 5167.8 5399.6 5605.9 5619.2 5646.7 5646.9 5132.6 5153.0 5177.0 5188.7 5197.8 5523.8 5527.3 5539.1 5565.0 5566.9 5239.9 5314.5 5403.9 5433.7 5459.9 5187.8 5193.5 5204.1 5207.6 5214.0 3757.8 3799.3 3799.5 3806.2 3807.4 5293.8 5332.9 5333.0 5541.6 5564.0 5336.5 5358.4 5393.7 5400.7 5455.3 5369.4 5373.9 5408.2 5410.6 5418.8 5111.3 5193.8 5264.0 5264.8 5316.3 5334.2 5358.4 5361.0 5383.4 5388.3 5271.0 5278.8 5301.3 5303.7 5306.4 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - PROCESS | 22434 | [#5] yui.html Cycles:180 Average:16654.78 Median:607.60 stddev:23387.67 (3849.2%) stddev-sans-first:23422.36 04:38:56 INFO - PROCESS | 22434 | Values: 640.7 651.1 662.1 711.2 750.4 11764.4 12638.2 12696.8 12703.9 12720.0 13716.5 14474.0 14501.3 15002.1 15070.5 619.0 792.4 796.5 798.0 803.4 782.4 801.4 804.0 806.8 812.7 839.1 843.6 844.2 845.2 846.4 828.2 831.0 832.6 833.0 835.4 609.0 609.4 609.5 610.1 611.3 13330.7 13384.3 13394.3 13410.3 13452.2 13622.1 13769.4 13787.7 13957.0 13960.3 9696.8 9710.9 9711.5 9879.7 10024.2 3391.5 3401.8 3423.2 3432.6 3442.0 59452.1 59555.7 60281.0 60966.4 61280.0 9675.6 9839.8 10252.5 10254.5 10269.7 20213.3 20330.2 20363.4 20407.3 20424.4 6236.2 6333.7 6569.7 6578.6 6598.2 3606.1 3607.9 3661.9 3668.3 3736.3 2725.9 2842.0 2844.4 2847.8 2850.4 502.7 522.8 528.5 529.4 533.0 433.7 489.8 584.8 606.2 612.4 8091.8 8096.5 8176.7 8355.9 8526.4 494.4 539.7 587.4 591.5 596.2 3850.9 3881.7 3924.5 3951.2 3985.4 85052.6 85289.6 88585.0 89279.0 89580.0 76100.0 77515.0 78168.0 78475.2 79866.2 70632.6 73215.3 73229.3 73277.3 73778.0 7426.5 7679.7 7758.1 7902.7 7907.1 42607.8 42689.8 42792.6 43407.6 43846.1 37501.0 40418.4 55022.4 61010.0 62565.4 10402.9 10518.5 10577.2 10647.7 11014.4 10678.0 10725.8 10742.5 11001.6 11250.0 9847.6 9939.2 9977.3 10014.4 10084.8 10342.6 10745.6 11011.4 11104.6 11158.6 9563.7 9570.5 9601.8 9634.6 9944.6 8376.2 8438.8 8523.1 8884.8 8895.3 8519.7 8847.4 8881.5 9118.9 9299.9 04:38:56 INFO - PROCESS | 22434 | -------- Summary: end -------- 04:38:56 INFO - PROCESS | 22434 | 04:38:56 INFO - TEST-INFO | 22434: exit 0 04:38:57 INFO - TEST-OK | dromaeo_css | took 1115342ms 04:38:57 INFO - TEST-START | kraken 04:38:57 INFO - operating with platform_type : linux_ 04:38:57 INFO - Initialising browser for kraken test... 04:38:57 INFO - TEST-INFO | started process 22666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR5IVVP/profile http://localhost:47360/getInfo.html) 04:39:02 INFO - PROCESS | 22666 | __metrics Screen width/height:1600/1200 04:39:02 INFO - PROCESS | 22666 | colorDepth:24 04:39:02 INFO - PROCESS | 22666 | Browser inner width/height: 1024/697 04:39:02 INFO - PROCESS | 22666 | __metrics 04:39:02 ERROR - PROCESS | 22666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2948: TypeError: this.tabs is undefined 04:39:03 INFO - TEST-INFO | 22666: exit 0 04:39:03 INFO - Browser initialized. 04:39:03 INFO - Running cycle 1/1 for kraken test... 04:39:03 INFO - TEST-INFO | started process 22785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR5IVVP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:16 INFO - PROCESS | 22785 | RSS: Main: 185507840 04:39:16 INFO - PROCESS | 22785 | 04:39:18 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47360/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:19 INFO - PROCESS | 22785 | RSS: Main: 189566976 04:39:19 INFO - PROCESS | 22785 | 04:39:22 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47360/tests/kraken/driver.html?testName=audio-dft) 04:39:23 INFO - PROCESS | 22785 | RSS: Main: 189255680 04:39:23 INFO - PROCESS | 22785 | 04:39:26 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47360/tests/kraken/driver.html?testName=audio-fft) 04:39:26 INFO - PROCESS | 22785 | RSS: Main: 185344000 04:39:26 INFO - PROCESS | 22785 | 04:39:28 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47360/tests/kraken/driver.html?testName=audio-oscillator) 04:39:29 INFO - PROCESS | 22785 | RSS: Main: 185696256 04:39:29 INFO - PROCESS | 22785 | 04:39:31 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47360/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:32 INFO - PROCESS | 22785 | RSS: Main: 185925632 04:39:32 INFO - PROCESS | 22785 | 04:39:35 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47360/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:36 INFO - PROCESS | 22785 | RSS: Main: 186327040 04:39:36 INFO - PROCESS | 22785 | 04:39:39 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47360/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:40 INFO - PROCESS | 22785 | RSS: Main: 183840768 04:39:40 INFO - PROCESS | 22785 | 04:39:43 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47360/tests/kraken/driver.html?testName=json-parse-financial) 04:39:43 INFO - PROCESS | 22785 | RSS: Main: 185151488 04:39:43 INFO - PROCESS | 22785 | 04:39:45 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47360/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:46 INFO - PROCESS | 22785 | RSS: Main: 185171968 04:39:46 INFO - PROCESS | 22785 | 04:39:48 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:48 INFO - PROCESS | 22785 | RSS: Main: 185573376 04:39:48 INFO - PROCESS | 22785 | 04:39:51 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:51 INFO - PROCESS | 22785 | RSS: Main: 186236928 04:39:51 INFO - PROCESS | 22785 | 04:39:54 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:55 INFO - PROCESS | 22785 | RSS: Main: 186347520 04:39:55 INFO - PROCESS | 22785 | 04:39:58 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:58 INFO - PROCESS | 22785 | RSS: Main: 186118144 04:39:58 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | Cycle 1(1): loaded http://localhost:47360/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47360/tests/kraken/driver.html?testName=ai-astar) 04:40:00 INFO - PROCESS | 22785 | RSS: Main: 186863616 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | __start_tp_report 04:40:00 INFO - PROCESS | 22785 | _x_x_mozilla_page_load 04:40:00 INFO - PROCESS | 22785 | _x_x_mozilla_page_load_details 04:40:00 INFO - PROCESS | 22785 | |i|pagename|runs| 04:40:00 INFO - PROCESS | 22785 | |0;ai-astar;114;109;123;115;116;115;115;113;113;114 04:40:00 INFO - PROCESS | 22785 | |1;audio-beat-detection;155;131;154;187;134;156;160;132;188;130 04:40:00 INFO - PROCESS | 22785 | |2;audio-dft;162;169;170;164;163;164;164;166;165;167 04:40:00 INFO - PROCESS | 22785 | |3;audio-fft;76;78;76;155;76;76;76;83;172;78 04:40:00 INFO - PROCESS | 22785 | |4;audio-oscillator;86;88;151;87;86;87;128;91;87;143 04:40:00 INFO - PROCESS | 22785 | |5;imaging-gaussian-blur;117;118;118;117;118;118;119;118;119;119 04:40:00 INFO - PROCESS | 22785 | |6;imaging-darkroom;150;152;147;148;147;147;147;147;150;154 04:40:00 INFO - PROCESS | 22785 | |7;imaging-desaturate;96;96;96;95;97;96;96;96;100;96 04:40:00 INFO - PROCESS | 22785 | |8;json-parse-financial;69;65;68;65;65;66;73;65;64;66 04:40:00 INFO - PROCESS | 22785 | |9;json-stringify-tinderbox;65;65;65;65;66;65;66;66;65;66 04:40:00 INFO - PROCESS | 22785 | |10;stanford-crypto-aes;86;83;90;91;86;91;85;88;119;93 04:40:00 INFO - PROCESS | 22785 | |11;stanford-crypto-ccm;146;139;137;143;135;139;148;136;136;139 04:40:00 INFO - PROCESS | 22785 | |12;stanford-crypto-pbkdf2;178;173;171;171;178;172;172;176;172;173 04:40:00 INFO - PROCESS | 22785 | |13;stanford-crypto-sha256-iterative;68;69;71;67;66;69;67;68;69;66 04:40:00 INFO - PROCESS | 22785 | __end_tp_report 04:40:00 INFO - PROCESS | 22785 | __start_cc_report 04:40:00 INFO - PROCESS | 22785 | _x_x_mozilla_cycle_collect,961 04:40:00 INFO - PROCESS | 22785 | __end_cc_report 04:40:00 INFO - PROCESS | 22785 | __startTimestamp1465472400786__endTimestamp 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | ------- Summary: start ------- 04:40:00 INFO - PROCESS | 22785 | Number of tests: 14 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:3.50 (3.0%) stddev-sans-first:3.70 04:40:00 INFO - PROCESS | 22785 | Values: 114.0 109.0 123.0 115.0 116.0 115.0 115.0 113.0 113.0 114.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#1] audio-beat-detection Cycles:10 Average:152.70 Median:155.50 stddev:21.75 (14.0%) stddev-sans-first:23.05 04:40:00 INFO - PROCESS | 22785 | Values: 155.0 131.0 154.0 187.0 134.0 156.0 160.0 132.0 188.0 130.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:2.59 (1.6%) stddev-sans-first:2.44 04:40:00 INFO - PROCESS | 22785 | Values: 162.0 169.0 170.0 164.0 163.0 164.0 164.0 166.0 165.0 167.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:36.60 (48.2%) stddev-sans-first:38.19 04:40:00 INFO - PROCESS | 22785 | Values: 76.0 78.0 76.0 155.0 76.0 76.0 76.0 83.0 172.0 78.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#4] audio-oscillator Cycles:10 Average:103.40 Median:87.00 stddev:26.34 (30.3%) stddev-sans-first:27.17 04:40:00 INFO - PROCESS | 22785 | Values: 86.0 88.0 151.0 87.0 86.0 87.0 128.0 91.0 87.0 143.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.67 04:40:00 INFO - PROCESS | 22785 | Values: 117.0 118.0 118.0 117.0 118.0 118.0 119.0 118.0 119.0 119.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:2.51 (1.7%) stddev-sans-first:2.64 04:40:00 INFO - PROCESS | 22785 | Values: 150.0 152.0 147.0 148.0 147.0 147.0 147.0 147.0 150.0 154.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 04:40:00 INFO - PROCESS | 22785 | Values: 96.0 96.0 96.0 95.0 97.0 96.0 96.0 96.0 100.0 96.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:66.00 stddev:2.72 (4.1%) stddev-sans-first:2.74 04:40:00 INFO - PROCESS | 22785 | Values: 69.0 65.0 68.0 65.0 65.0 66.0 73.0 65.0 64.0 66.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 04:40:00 INFO - PROCESS | 22785 | Values: 65.0 65.0 65.0 65.0 66.0 65.0 66.0 66.0 65.0 66.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:89.00 stddev:10.26 (11.5%) stddev-sans-first:10.71 04:40:00 INFO - PROCESS | 22785 | Values: 86.0 83.0 90.0 91.0 86.0 91.0 85.0 88.0 119.0 93.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:139.00 stddev:4.44 (3.2%) stddev-sans-first:4.11 04:40:00 INFO - PROCESS | 22785 | Values: 146.0 139.0 137.0 143.0 135.0 139.0 148.0 136.0 136.0 139.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:173.00 stddev:2.72 (1.6%) stddev-sans-first:2.37 04:40:00 INFO - PROCESS | 22785 | Values: 178.0 173.0 171.0 171.0 178.0 172.0 172.0 176.0 172.0 173.0 04:40:00 INFO - PROCESS | 22785 | 04:40:00 INFO - PROCESS | 22785 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.50 stddev:1.56 (2.3%) stddev-sans-first:1.66 04:40:00 INFO - PROCESS | 22785 | Values: 68.0 69.0 71.0 67.0 66.0 69.0 67.0 68.0 69.0 66.0 04:40:00 INFO - PROCESS | 22785 | -------- Summary: end -------- 04:40:00 INFO - PROCESS | 22785 | 04:40:01 INFO - TEST-INFO | 22785: exit 0 04:40:02 INFO - TEST-OK | kraken | took 64991ms 04:40:02 INFO - SUITE-END | took 1180s 04:40:02 INFO - Completed test suite (00:19:40) 04:40:02 INFO - javascript benchmark 04:40:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6323.96721085513, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2545.3636590852284, 2627.5664515354965, 2644.65619469469, 2672.412069344745, 2676.7189445108265, 4752.572268495835, 4785.377900872886, 4851.320815085891, 4861.611071114311, 4863.440704319004, 4692.882677933053, 4788.545088216622, 4822.855314340567, 4854.3446634704305, 4855.1018061658615, 4384.69307148499, 4414.80133393998, 4430.047539778947, 4509.729416235036, 4514.503404625489, 4427.313766366218, 4441.555844415549, 4486.663500237479, 4495.43807024122, 4547.772611369435, 4261.296886013804, 4414.757188354639, 4422.889427764299, 4434.423524941753, 4468.75421851798, 4455.688101832873, 4470.441194850644, 4472.664550158718, 4477.552244775497, 4520.480144783326, 4429.247028005247, 4448.3549885266775, 4458.509563947963, 4458.621017213541, 4488.663350248712, 4755.952440475586, 4814.566688997972, 4824.445188803297, 4826.300186472942, 4852.150873597142, 5190.92213616796, 5217.8173763918085, 5233.1365324721755, 5237.371515418136, 5287.0, 5016.247562865563, 5152.381714194284, 5237.685738855643, 5253.028189784902, 5257.684538927639, 4812.398450193726, 4841.3222148899185, 4863.0, 4863.367762190893, 4916.827911023097, 5278.366596008426, 5296.3909150447425, 5301.496357845998, 5342.2787923630585, 5347.491988261109, 4837.806487740521, 4999.350084488993, 5083.822066227664, 5110.131277682803, 5116.104681680766, 5036.11867923112, 5126.769295381642, 5192.870178245574, 5214.165733482625, 5256.553192978639, 5130.87172820675, 5131.409887862944, 5152.0211159880255, 5156.20078887773, 5161.200013997836, 5002.474740152232, 5038.546530812245, 5051.116054690415, 5151.871203219949, 5198.9740051299505, 4395.296752519582, 4406.559344065632, 4414.713043652217, 4446.82212711488, 4461.665375096881, 3782.678472329828, 3788.109794198361, 3819.1597848473293, 3846.0384903774057, 3875.3411919973673, 4348.913021739548, 4471.575200355961, 4485.058137791035, 4506.324051392252, 4525.230710779176, 5191.169412893919, 5225.503577160163, 5226.085435048852, 5241.947580524146, 5288.709120998382, 4512.0, 4513.819447222074, 4520.59314661682, 4524.728516289033, 4561.133384656904, 4554.316852472156, 4660.300954856799, 4674.883127921829, 4709.058188362341, 4736.455307639666, 4870.220764677634, 4875.585575226146, 4880.6095512358215, 4893.388326459192, 4934.3338649282605, 5067.493250674903, 5229.529342359206, 5236.0575096483, 5236.18839079928, 5295.629305948701, 4851.46633870281, 4863.756812159307, 4882.170031094652, 4886.0, 4910.337104490848, 5140.537351638371, 5145.588352931682, 5161.174212126042, 5173.560247378864, 5208.8437346879655, 5035.949640503694, 5121.743912804271, 5224.0, 5225.268462415341, 5229.215617657382, 4838.806447742051, 4999.0, 5041.0422019816115, 5105.2342148678, 5122.103631864335, 5098.566621837185, 5103.617228707936, 5105.744712764421, 5124.7950081996305, 5151.639385242997, 4818.975905120452, 4995.925061124013, 5014.924776128434, 5018.573421259234, 5029.396472423333, 5034.194528875362, 5052.292679024866, 5075.974620126875, 5091.338126043591, 5107.259447380184, 4975.502449754996, 4979.402471703419, 4982.825601103944, 4989.575886049582, 5032.245163225545], "value": 4753.8922245392405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.9361329833771, 566.9234653321801, 571.180356188869, 577.3648986115272, 582.2198254339185, 38997.220055598904, 40432.59567404325, 40463.19073618526, 40492.99999999996, 45210.773946130306, 39732.602673973255, 39906.600933990725, 40082.398764018566, 40118.0, 40412.0, 7803.921960780404, 7932.801679957989, 7944.523328600274, 7961.1242763295995, 7968.920310796905, 7808.219178082203, 7927.207279272085, 7941.364690824749, 7949.205079492033, 7960.9203907960755, 7868.52788832669, 7901.48640338379, 7953.045634523836, 7957.840843183133, 7990.7602771916645, 7868.921310786876, 7892.447528672995, 7938.0077490313715, 7944.761657150295, 7967.521948683039, 7903.486273392211, 7910.4067194960035, 7950.880736788953, 7974.3221826144845, 7979.760607181794, 38183.427248591295, 38492.0, 38579.03552411212, 38614.22771544554, 38643.420348694795, 3066.74953387197, 3156.779025468218, 3182.618085829692, 3195.0893995211486, 3223.7098661120376, 28970.710292897224, 29334.266643333875, 29351.55972660412, 29509.557356639667, 29579.260518486994, 3005.594244776949, 3056.5415187721796, 3087.428825667259, 3107.1610665120515, 3155.021943197593, 263130.0, 266391.0, 266858.0, 267596.0, 268379.0, 31566.210844729067, 47884.28173577399, 47980.280295795594, 48285.0, 48477.0, 32112.518312225337, 34175.82912085473, 34270.828645856614, 34321.141971450415, 34354.0, 12829.807552886714, 12851.614451566467, 12862.228266304051, 12863.42114604845, 12890.548830791065, 10932.945335273433, 10945.288556243819, 10975.341479511255, 11037.613683521038, 11063.502142403611, 7870.763877083697, 7887.645055972495, 7911.169327220674, 7916.287534121957, 7919.445638805229, 3106.9067927962196, 3109.4092122496654, 3111.455495288361, 3124.094012736281, 3167.255694911694, 863.6545381847186, 880.7225723896952, 907.3603109807569, 948.9810203796023, 1013.476443655293, 28052.43895122086, 28105.859470702515, 28352.0, 28523.89065708712, 28858.567121493194, 900.9954950225207, 968.651285537206, 1019.7960407918298, 1024.99487502562, 1033.6692258477365, 14271.500497482539, 14680.779788303184, 14924.850751492346, 14977.176255306063, 15090.471833485775, 401863.0, 405925.0, 406185.0, 406689.0, 409237.0, 49542.75228623834, 50765.0, 50897.745511272944, 50957.74521127371, 51065.234021489705, 1187.0978056676815, 1187.4834447015576, 1204.5783975608642, 1208.383724300613, 1214.4595654933646, 26271.868640656674, 27208.319792005357, 27384.178474645792, 27560.862195688893, 28075.859620701765, 40720.38919416152, 40875.591244087176, 41331.1733765317, 41719.58280417157, 41743.7912810434, 255744.0, 256782.0, 334857.0, 336383.0, 337192.0, 25268.368290792878, 25284.747152528977, 26249.343766405993, 26447.60328595111, 27592.862035689694, 42226.36660450034, 42266.0, 42652.5734742661, 43048.35427468653, 43345.78327108344, 36204.0, 36764.63235367612, 36827.631723683495, 36955.0, 37573.24853502969, 37197.44203836999, 37318.25363492769, 37466.43800342942, 37718.8114059428, 37734.62265377421, 31330.373392532478, 35121.1219719509, 36519.0, 37007.25985480329, 37260.0, 32560.185995350304, 33201.50197747084, 33443.498347525296, 33808.49287260644, 33968.15079623029, 25243.368915777253, 25669.783174847023, 25766.613500797128, 25769.0, 26149.34626634273], "value": 16510.330781173096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.1975136812383, 351.2781234562973, 360.682599312605, 363.0451911472826, 370.29274086494786, 15747.527574172778, 16813.83186168138, 17590.29638814446, 17823.910880445597, 17891.73162402565, 15441.768373474408, 15623.609409764762, 16552.917235413806, 16558.254878530464, 16593.83406165938, 4879.926801097995, 5063.544281014708, 5102.902875881685, 5109.3613298337705, 5111.182210846266, 3719.572249191337, 4986.675866068694, 5569.805056823012, 5882.264716910387, 5889.381614930414, 5908.970455147718, 5911.142884281777, 5915.467607915287, 5921.911171332434, 5975.850603734898, 5706.1440783882545, 5830.271216097988, 5871.588988770788, 5909.349971503131, 5912.911306330387, 4529.569690879362, 5043.747812609355, 5068.113080210948, 5074.594032477393, 5089.770960306795, 18270.269189232415, 18843.71734423985, 19630.803691963185, 19689.409317720492, 19717.30989415378, 1749.8862573932654, 1779.973300400495, 1812.8821626594229, 1826.7168588868747, 1985.0967809646577, 8338.416310858242, 8512.276456501142, 8950.194482496541, 9019.278457723367, 9024.729258122266, 1634.6403791165924, 1650.5460998225465, 1705.5821323775754, 1734.6877562038828, 1789.5347209725435, 69008.0, 71078.64460677664, 71231.64384178098, 71925.64037179781, 72038.0, 9792.804143917225, 9907.811062672381, 9999.450030248407, 10285.177185825116, 10835.241533092765, 13689.657758556115, 13812.516561920285, 13902.930485347508, 13915.373808178656, 13951.232682202373, 7063.1524217094275, 7084.468664850054, 7160.606166660779, 7174.748883789147, 7213.278672132745, 6560.278369379364, 6562.573432726953, 6626.271110177877, 6678.131842860397, 6770.898436523456, 4206.47419072616, 4245.469316335458, 4263.189993901149, 4301.612854843017, 4381.9123617527475, 1652.6777278430832, 1658.209134135131, 1817.7000794868698, 1848.1867978089597, 1898.4399602117408, 759.9620018999028, 826.2852632472868, 887.174927317588, 901.5942825728448, 962.4033099478369, 16160.676786464204, 16449.588760281087, 16490.34038638465, 16521.91739041321, 16858.0, 851.714675583674, 883.7481317824389, 905.5608030105394, 907.3920473282784, 940.6707652321633, 9189.954050229706, 9398.778158839445, 9402.43585384879, 9448.811023779623, 10267.589296428208, 397948.0, 407383.0, 416798.0, 423804.0, 426653.0, 80084.59957700175, 80371.0, 81414.0, 81641.0, 84451.0, 931.6878845586805, 949.378157306965, 950.4249928793118, 958.6309270930742, 962.3359881681617, 15645.530634080997, 15721.292541835415, 15808.60478488047, 15996.920015399848, 16015.519534413987, 36144.45783313305, 36529.81735091307, 36776.08059798527, 37581.24837503289, 37794.81102594469, 49036.2644560339, 49399.75300123476, 50179.24731129109, 50511.24233136579, 50954.74522627363, 7628.923710762821, 7763.650635721293, 7782.92217077822, 7882.605869706377, 7990.400719946144, 6742.9662851685425, 9896.802063958536, 11069.833952490559, 12162.331071791137, 12413.317267550372, 9558.426494410358, 9685.9031409685, 9728.221742260745, 9926.751831204278, 10376.221783366127, 10126.341787783771, 10139.89860101419, 10289.588416463557, 10365.481725913825, 10371.58513659445, 8361.038480574813, 9439.622415103318, 9962.203023758228, 10294.845577316497, 10405.06354428105, 7766.145723970471, 7820.0, 7877.803054923673, 7888.684452621831, 7986.321162701235, 10015.899841001497, 10603.840942386025, 10735.463226838783, 10917.0, 10966.780664386828], "value": 8161.130244661554, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.6070969773616, 1403.8034675145477, 1460.7297649934762, 1657.668466306739, 1679.3114822922605, 6543.280239173687, 7053.224145344008, 7144.964275178623, 7640.197779233184, 7658.92341076589, 7084.822879428017, 7163.498555101145, 7315.0, 7391.815204619874, 7392.519486233391, 2093.382452176604, 2126.6597344424895, 2137.9893100534555, 2141.4539292480395, 2152.257471172443, 2091.1426315210765, 2105.9368218953455, 2152.117631770974, 2152.827773778094, 2160.1791319298723, 2070.130545171024, 2096.8846713430753, 2098.674705420662, 2104.431803413085, 2120.226117467121, 2094.4135642020183, 2105.0632468551576, 2120.936371908845, 2124.6069477146775, 2134.3916983659583, 2077.979220207809, 2096.308218287961, 2103.8422118341186, 2105.0316854247067, 2107.7365329333834, 7481.5885126318035, 7538.773836784905, 7551.773446796605, 7566.319031287156, 7574.772756817304, 4430.069685366045, 4490.461144662661, 4529.09418116378, 4529.977350113229, 4532.954670453286, 2721.306066952934, 2785.5960885671666, 2816.098848368523, 2825.110090321542, 2867.555528893025, 863.197226579281, 881.3037700216821, 908.3823000359753, 911.6490151291734, 920.3373571028849, 9960.352577082538, 10151.64469243573, 10173.694789156338, 10200.285979981478, 10228.74428139295, 4009.358502639622, 4032.6773858091283, 4098.405731168964, 4124.092699606082, 4124.608162224584, 8782.989956155125, 8802.911970880337, 8818.382713210141, 8842.91157088421, 8844.955775221082, 4414.955850441519, 4429.047754732748, 4448.266036104072, 4467.955320446819, 4482.8655140345845, 3489.668481494254, 3943.684505239574, 4063.91872162561, 4111.177764447122, 4149.958500414958, 3572.1426857554, 3587.3722098632634, 3621.764585301947, 3659.9268014639556, 3768.9057773555332, 1138.248755821154, 1151.9136064795173, 1170.5610396101463, 1171.4435643069644, 1181.031554125626, 792.1484404265437, 800.2237829305565, 814.5601375257295, 819.2422009641058, 837.7277384849948, 5036.194208926554, 5065.0, 5081.0854046272025, 5084.618653600995, 5085.923711144335, 807.9313258373104, 835.6406745099544, 871.7515508080294, 906.6373450619673, 907.7140700679265, 3574.285142971416, 3617.0, 3658.1037645776423, 3691.1141326082084, 3777.962220377816, 9037.50293733851, 9263.25893928484, 9350.532473376305, 9365.203957663674, 9380.812383752287, 9154.542272886329, 9247.213986811063, 9250.352475326663, 9312.0, 9324.95337523308, 6840.905455127156, 7054.92945070553, 7078.1860086090755, 7083.468739844532, 7114.501984861114, 5011.899762004667, 5109.284700142058, 5333.040052790535, 5471.261379713687, 5492.066348720807, 8420.747377578682, 8450.112738162405, 8473.5339556325, 8536.871946920677, 8668.089850565852, 8015.799605009922, 8324.958375208085, 8336.833263334578, 8530.445521041112, 8629.39594228398, 5865.501432378125, 6152.477039451696, 6417.8716425672155, 6491.740330386731, 6690.13028306317, 7273.599952002691, 7329.267073292628, 7342.48602597813, 7344.742933997284, 7357.411407087528, 6547.181602299713, 6632.568883022588, 6735.966320168368, 6741.325867413219, 6788.185417749902, 6489.935100648933, 6544.6727663615675, 6552.3775241352, 6606.273309935807, 6663.766768163091, 6034.155218269358, 6086.360932102242, 6099.817005489843, 6127.601705889103, 6164.352742961924, 4192.517860446088, 4327.76197309151, 4363.934540981824, 4376.6717496187275, 4383.364412160283, 4276.059266961263, 4277.98966351663, 4343.761093139908, 4352.129574085132, 4368.410264614236], "value": 4015.071675606031, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.1999601126816, 287.8201124297314, 293.76352036610524, 295.1587974273323, 297.7558402110269, 4887.486813884544, 4965.404151501816, 4972.875678108045, 5111.642185047043, 5147.5109864562855, 5023.899522009558, 5088.236764485329, 5093.719845408501, 5105.591552675786, 5133.4609865964, 3977.6420122188997, 3978.5225772907147, 3979.8010099495054, 3986.242613903349, 3989.6010398960016, 3892.630200130983, 3939.9015024624327, 3988.421678856564, 3990.7206495545324, 3996.5603783583783, 3890.513685789276, 3907.433422153786, 3916.686665066802, 3917.373220284755, 3930.547986981491, 3894.610538946111, 3923.293807114718, 3931.1720050176664, 3935.3900145477496, 3940.6453419192126, 3478.478228265755, 3481.1123163593375, 3485.1809824691177, 3495.458203978362, 3512.227309991798, 4895.412550493964, 4924.679895806761, 4967.478414766434, 4989.625778066623, 5063.544281014726, 4476.776161191928, 4517.661175411858, 4525.434320709911, 4530.909381812378, 4547.067851090518, 5357.4106848246665, 5368.570514358842, 5371.623986320959, 5385.21914322425, 5396.487333703292, 3458.5330980317585, 3641.817909104561, 3668.0, 3800.4299355096955, 3808.866689665876, 5566.693831839288, 5571.192177134293, 5612.102063669793, 5632.732635157057, 5643.830685079454, 3746.9508537609513, 3749.643783840531, 3760.9811950940616, 3771.245750849841, 3776.962230377661, 3594.982025089858, 3779.281936432069, 3798.734088613826, 3804.5624753153743, 3823.6176382362096, 4316.69783115179, 4324.870253892388, 4335.328024156261, 4369.650427965755, 4376.0, 5231.346081739783, 5251.238570407269, 5271.736413179326, 5284.0, 5306.204069389622, 1203.8194270859267, 1271.4469205895466, 1309.2013871538354, 1310.4561606933207, 1311.252586025975, 809.7854068671807, 813.4305985809957, 826.8387664405383, 836.4145098431122, 839.3788596438592, 4091.365838295069, 4126.401671757579, 4142.420061191436, 4170.311024035271, 4212.705110642226, 4673.976630116827, 4693.22561777303, 4749.881252968704, 4756.904861902743, 4757.381540399795, 4087.6525495332635, 4131.855385061569, 4169.499660040815, 4214.768187749703, 4223.767692776865, 2620.2663254288827, 2703.8783254753585, 2941.6027386991436, 2945.39619378027, 2954.1875984104545, 5116.872078198075, 5124.9743751281, 5132.1788513838355, 5162.6902385856965, 5167.793288268427, 5399.6490228135835, 5605.859853503695, 5619.185218143346, 5646.689432081275, 5646.915296270559, 5132.589392848563, 5153.0, 5177.0, 5188.662736922088, 5197.766100525486, 5523.834284971457, 5527.309086364205, 5539.141433077718, 5564.972175139098, 5566.942280966603, 5239.895202096013, 5314.5482633975, 5403.9459605403445, 5433.728313584384, 5459.945400546103, 5187.766550505161, 5193.454687257784, 5204.063268611686, 5207.583393328448, 5214.0, 3757.8308976096687, 3799.297130030953, 3799.506064211635, 3806.1626442182674, 3807.428885667172, 5293.841184764463, 5332.946670533245, 5332.963538932534, 5541.639793413416, 5563.970665426909, 5336.532453575298, 5358.4105748366865, 5393.730313484231, 5400.729963501888, 5455.3453585568395, 5369.436209197978, 5373.946260537345, 5408.215808707637, 5410.620291825559, 5418.7783008966135, 5111.309973153577, 5193.76628051731, 5263.973680131728, 5264.842054738364, 5316.282301889196, 5334.199870019528, 5358.356997160366, 5361.0, 5383.380911195262, 5388.2725832012175, 5270.973645131749, 5278.788848446173, 5301.310829592128, 5303.681779093266, 5306.389765177054], "value": 3931.513360677431, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.6508452893173, 651.1307404614842, 662.076403417233, 711.2247650061432, 750.3659407800409, 11764.411779411028, 12638.241705497676, 12696.80954785679, 12703.872961270385, 12720.0, 13716.451341946335, 14474.0, 14501.274936253198, 15002.099874007567, 15070.547883563484, 619.0, 792.4096548071681, 796.5021861336664, 797.9800504987393, 803.3693550562809, 782.35846605783, 801.3749275565068, 803.9718609848657, 806.8063664720484, 812.7317985064915, 839.1147339556766, 843.616154649636, 844.2190973349658, 845.247729520727, 846.4328899637227, 828.1925123005082, 831.031847897202, 832.5753865528563, 833.0461621443444, 835.4110352201714, 609.0, 609.4240942309519, 609.5276160975235, 610.0513701194641, 611.2664802237289, 13330.666733331647, 13384.330783460788, 13394.330283485884, 13410.329483525882, 13452.192868427926, 13622.114562553403, 13769.380377883019, 13787.724245515134, 13957.0, 13960.301984900714, 9696.806063878683, 9710.854337184948, 9711.54517264415, 9879.703608891745, 10024.248181386425, 3391.542141810873, 3401.812900290483, 3423.1613254752497, 3432.5537680101675, 3442.0, 59452.10821837676, 59555.70222148862, 60281.0, 60966.39033609651, 61279.999999999556, 9675.645409642655, 9839.803203936024, 10252.487375631188, 10254.48727563619, 10269.691909242734, 20213.292534761214, 20330.186792528133, 20363.389098327072, 20407.285744998855, 20424.38726838197, 6236.158118654014, 6333.65164915934, 6569.737210511622, 6578.638174900427, 6598.241202261801, 3606.1165014571075, 3607.9278414431565, 3661.853525858989, 3668.321360548307, 3736.252749450121, 2725.8637068146513, 2841.9857900710776, 2844.360018995709, 2847.800653954245, 2850.4299140171634, 502.6983809714142, 522.7673685210045, 528.4952870009132, 529.3837734951219, 532.97068661224, 433.6639104693887, 489.7560197099399, 584.7923986984645, 606.1998162425556, 612.4212619074931, 8091.757247282591, 8096.51420914747, 8176.713815016446, 8355.916440835636, 8526.445781024213, 494.44622023334097, 539.7382269599241, 587.4243241623233, 591.520868096843, 596.1594152245314, 3850.8844734658005, 3881.6894648428056, 3924.50943632046, 3951.209758048402, 3985.4221137934837, 85052.57473712716, 85289.57355213308, 88585.0, 89279.0, 89580.0, 76100.0, 77515.0, 78168.0, 78475.21524784793, 79866.20133798703, 70632.64683676549, 73215.26784732085, 73229.26770732224, 73277.2672273281, 73778.0, 7426.517276377018, 7679.69281228767, 7758.107817601048, 7902.68389264423, 7907.090684571348, 42607.786961064994, 42689.786551067045, 42792.57207427886, 43407.56592434035, 43846.12307753763, 37501.0, 40418.39372409475, 55022.44977550334, 61010.0, 62565.37434625596, 10402.895971040192, 10518.474076296308, 10577.153827693919, 10647.733806654896, 11014.44927753625, 10678.0, 10725.785484290427, 10742.462876855969, 11001.559937602406, 11250.0, 9847.60609575609, 9939.204863610748, 9977.251706122215, 10014.39913605186, 10084.848727269244, 10342.638007669695, 10745.570177192825, 11011.394373309546, 11104.555817767521, 11158.553657853596, 9563.665271715456, 9570.521473926137, 9601.759956000877, 9634.614615415305, 9944.552495137592, 8376.204260595478, 8438.789030274293, 8523.147685231428, 8884.777880553038, 8895.2883769297, 8519.74440766778, 8847.42491738035, 8881.511516866634, 9118.908810912071, 9299.860502092339], "value": 6325.328401532445, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 123.0, 115.0, 116.0, 115.0, 115.0, 113.0, 113.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 154.0, 187.0, 134.0, 156.0, 160.0, 132.0, 188.0, 130.0], "value": 152.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 169.0, 170.0, 164.0, 163.0, 164.0, 164.0, 166.0, 165.0, 167.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 155.0, 76.0, 76.0, 76.0, 83.0, 172.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 151.0, 87.0, 86.0, 87.0, 128.0, 91.0, 87.0, 143.0], "value": 103.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 118.0, 119.0, 118.0, 119.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 150.0, 154.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 100.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 68.0, 65.0, 65.0, 66.0, 73.0, 65.0, 64.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 90.0, 91.0, 86.0, 91.0, 85.0, 88.0, 119.0, 93.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 137.0, 143.0, 135.0, 139.0, 148.0, 136.0, 136.0, 139.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 173.0, 171.0, 171.0, 178.0, 172.0, 172.0, 176.0, 172.0, 173.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 71.0, 67.0, 66.0, 69.0, 67.0, 68.0, 69.0, 66.0], "value": 68.0, "unit": "score"}]}]} 04:40:02 INFO - Return code: 0 04:40:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:40:02 ERROR - # TBPL SUCCESS # 04:40:02 INFO - Running post-action listener: _resource_record_post_action 04:40:02 INFO - ##### 04:40:02 INFO - ##### Finished run-tests step (success) 04:40:02 INFO - ##### 04:40:02 INFO - Running post-run listener: _resource_record_post_run 04:40:02 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534355968; Read time: 20; Write time: 583636 04:40:02 INFO - TinderboxPrint: CPU usage
13.5% 04:40:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:40:02 INFO - TinderboxPrint: I/O write bytes / time
534,355,968 / 583,636 04:40:02 INFO - TinderboxPrint: CPU idle
8,267.3 (86.5%) 04:40:02 INFO - TinderboxPrint: CPU user
1,230.1 (12.9%) 04:40:02 INFO - TinderboxPrint: Swap in / out
0 / 0 04:40:02 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237432832; Read time: 0; Write time: 333348 04:40:02 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 295849984; Read time: 20; Write time: 249760 04:40:03 INFO - Running post-run listener: _upload_blobber_files 04:40:03 INFO - Blob upload gear active. 04:40:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:40:03 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:03 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:03 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:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:40:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:40:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:40:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:04 INFO - (blobuploader) - INFO - Done attempting. 04:40:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:40:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:40:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:07 INFO - (blobuploader) - INFO - Done attempting. 04:40:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:40:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:40:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:40:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:40:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:40:08 INFO - (blobuploader) - INFO - Done attempting. 04:40:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:40:08 INFO - Return code: 0 04:40:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:40:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:40:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6456acbec0eae10e505f30d299ec9e14d8da8097c33969fc6897a8851342cae11e92efcfcbe87252530924b615ac2787a3eb87028c7fe921f4e10683ae7d9e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34f8a7f2993ab87b1b5811b8c6d757335f9c521d5b5c618dc4c587b5d7dd645b02616ac1b9aaf82b76985da6f8538a2d296fc8b688535a2c5e2340b275c67400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/199ca4e3582e20032a5c0c021e138e8c28a2362ba4ae85437a0a5978754e3918ad14348e008be2716f5e81ad95f4fdeac861497eb4c1aeaf52d94d6bcf98d041"} 04:40:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:40:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:40:08 INFO - Contents: 04:40:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6456acbec0eae10e505f30d299ec9e14d8da8097c33969fc6897a8851342cae11e92efcfcbe87252530924b615ac2787a3eb87028c7fe921f4e10683ae7d9e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34f8a7f2993ab87b1b5811b8c6d757335f9c521d5b5c618dc4c587b5d7dd645b02616ac1b9aaf82b76985da6f8538a2d296fc8b688535a2c5e2340b275c67400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/199ca4e3582e20032a5c0c021e138e8c28a2362ba4ae85437a0a5978754e3918ad14348e008be2716f5e81ad95f4fdeac861497eb4c1aeaf52d94d6bcf98d041"} 04:40:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:40:08 INFO - Copying logs to upload dir... 04:40:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:40:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.956933 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2016-06-09 04:40:07.793898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:07.798025) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6456acbec0eae10e505f30d299ec9e14d8da8097c33969fc6897a8851342cae11e92efcfcbe87252530924b615ac2787a3eb87028c7fe921f4e10683ae7d9e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34f8a7f2993ab87b1b5811b8c6d757335f9c521d5b5c618dc4c587b5d7dd645b02616ac1b9aaf82b76985da6f8538a2d296fc8b688535a2c5e2340b275c67400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/199ca4e3582e20032a5c0c021e138e8c28a2362ba4ae85437a0a5978754e3918ad14348e008be2716f5e81ad95f4fdeac861497eb4c1aeaf52d94d6bcf98d041"} 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.011433 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6456acbec0eae10e505f30d299ec9e14d8da8097c33969fc6897a8851342cae11e92efcfcbe87252530924b615ac2787a3eb87028c7fe921f4e10683ae7d9e43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/34f8a7f2993ab87b1b5811b8c6d757335f9c521d5b5c618dc4c587b5d7dd645b02616ac1b9aaf82b76985da6f8538a2d296fc8b688535a2c5e2340b275c67400", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/199ca4e3582e20032a5c0c021e138e8c28a2362ba4ae85437a0a5978754e3918ad14348e008be2716f5e81ad95f4fdeac861497eb4c1aeaf52d94d6bcf98d041"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:07.823612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:07.823980) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1465470789.318552-1873144162 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004493 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-09 04:40:07.907832) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:40:07.908146) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-09 04:40:07.908432) ========= ========= Total master_lag: 0.16 =========