builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-022 starttime: 1466498785.73 results: success (0) buildid: 20160621004800 builduid: 1287937dc5f549abb92e0fe6cffc8be0 revision: be179bb8c58ff829b3c81cbc203833686dd3739e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.729732) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.730228) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.730542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.776969) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.777330) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 01:46:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-06-21 01:46:26 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124857 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.920084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.920407) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020644 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.971627) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:46:25.972006) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be179bb8c58ff829b3c81cbc203833686dd3739e --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 be179bb8c58ff829b3c81cbc203833686dd3739e --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=9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 01:46:26,421 truncating revision to first 12 chars 2016-06-21 01:46:26,422 Setting DEBUG logging. 2016-06-21 01:46:26,422 attempt 1/10 2016-06-21 01:46:26,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be179bb8c58f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 01:46:27,890 unpacking tar archive at: fx-team-be179bb8c58f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.829219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:46:27.816845) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.817184) ========= script_repo_revision: be179bb8c58ff829b3c81cbc203833686dd3739e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.817701) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.818042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.827150) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-21 01:46:27.827596) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:28 INFO - MultiFileLogger online at 20160621 01:46:28 in /builds/slave/test 01:46:28 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 01:46:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:46:28 INFO - {'append_to_log': False, 01:46:28 INFO - 'base_work_dir': '/builds/slave/test', 01:46:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:46:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:46:28 INFO - 'branch': 'Fx-Team-Non-PGO', 01:46:28 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:28 INFO - 'config_files': ('talos/linux_config.py',), 01:46:28 INFO - 'default_actions': ('clobber', 01:46:28 INFO - 'read-buildbot-config', 01:46:28 INFO - 'download-and-extract', 01:46:28 INFO - 'populate-webroot', 01:46:28 INFO - 'create-virtualenv', 01:46:28 INFO - 'install', 01:46:28 INFO - 'run-tests'), 01:46:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:28 INFO - 'download_minidump_stackwalk': True, 01:46:28 INFO - 'download_symbols': 'ondemand', 01:46:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:28 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:28 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:28 INFO - 'installer_path': 'installer.exe', 01:46:28 INFO - 'log_level': 'info', 01:46:28 INFO - 'log_name': 'talos', 01:46:28 INFO - 'log_to_console': True, 01:46:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:28 INFO - 'opt_config_files': (), 01:46:28 INFO - 'pip_index': False, 01:46:28 INFO - 'sps_profile': False, 01:46:28 INFO - 'sps_profile_interval': 0, 01:46:28 INFO - 'suite': 'dromaeojs-e10s', 01:46:28 INFO - 'system_bits': '32', 01:46:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:28 INFO - 'title': 'talos-linux64-ix-022', 01:46:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:28 INFO - 'use_talos_json': True, 01:46:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:46:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:28 INFO - 'work_dir': 'build'} 01:46:28 INFO - ##### 01:46:28 INFO - ##### Running clobber step. 01:46:28 INFO - ##### 01:46:28 INFO - Running pre-action listener: _resource_record_pre_action 01:46:28 INFO - Running main action method: clobber 01:46:28 INFO - rmtree: /builds/slave/test/build 01:46:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:46:29 INFO - Running post-action listener: _resource_record_post_action 01:46:29 INFO - ##### 01:46:29 INFO - ##### Finished clobber step (success) 01:46:29 INFO - ##### 01:46:29 INFO - ##### 01:46:29 INFO - ##### Running read-buildbot-config step. 01:46:29 INFO - ##### 01:46:29 INFO - Running pre-action listener: _resource_record_pre_action 01:46:29 INFO - Running main action method: read_buildbot_config 01:46:29 INFO - Using buildbot properties: 01:46:29 INFO - { 01:46:29 INFO - "project": "", 01:46:29 INFO - "product": "firefox", 01:46:29 INFO - "script_repo_revision": "production", 01:46:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:46:29 INFO - "repository": "", 01:46:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:46:29 INFO - "buildid": "20160621004800", 01:46:29 INFO - "pgo_build": "False", 01:46:29 INFO - "basedir": "/builds/slave/test", 01:46:29 INFO - "buildnumber": 1375, 01:46:29 INFO - "slavename": "talos-linux64-ix-022", 01:46:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:46:29 INFO - "platform": "ubuntu64_hw", 01:46:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:46:29 INFO - "branch": "fx-team", 01:46:29 INFO - "repo_path": "integration/fx-team", 01:46:29 INFO - "revision": "be179bb8c58ff829b3c81cbc203833686dd3739e", 01:46:29 INFO - "stage_platform": "linux64", 01:46:29 INFO - "builduid": "1287937dc5f549abb92e0fe6cffc8be0", 01:46:29 INFO - "slavebuilddir": "test" 01:46:29 INFO - } 01:46:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:46:29 INFO - Running post-action listener: _resource_record_post_action 01:46:29 INFO - ##### 01:46:29 INFO - ##### Finished read-buildbot-config step (success) 01:46:29 INFO - ##### 01:46:29 INFO - ##### 01:46:29 INFO - ##### Running download-and-extract step. 01:46:29 INFO - ##### 01:46:29 INFO - Running pre-action listener: _resource_record_pre_action 01:46:29 INFO - Running main action method: download_and_extract 01:46:29 INFO - mkdir: /builds/slave/test/build/tests 01:46: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')]} 01:46:29 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:46:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:35 INFO - Downloaded 1361 bytes. 01:46:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:35 INFO - Using the following test package requirements: 01:46:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:46:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:46:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'jsshell-linux-x86_64.zip'], 01:46:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:46:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:46:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:46:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:46:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:46:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:46: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')]} 01:46:35 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:37 INFO - Downloaded 22654960 bytes. 01:46:37 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'] 01:46:37 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 01:46:38 INFO - Return code: 0 01:46:38 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 01:46:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:38 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:46 INFO - Downloaded 22654960 bytes. 01:46:46 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'] 01:46:46 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 01:46:47 INFO - Return code: 0 01:46: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')]} 01:46:47 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:48 INFO - Downloaded 14405384 bytes. 01:46:48 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'] 01:46:48 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 01:46:49 INFO - Return code: 0 01:46: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')]} 01:46:49 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/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 01:46:53 INFO - Downloaded 56230407 bytes. 01:46:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:53 INFO - mkdir: /builds/slave/test/properties 01:46:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:53 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:53 INFO - Contents: 01:46:53 INFO - build_url:https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:54 INFO - Running post-action listener: _resource_record_post_action 01:46:54 INFO - Running post-action listener: set_extra_try_arguments 01:46:54 INFO - ##### 01:46:54 INFO - ##### Finished download-and-extract step (success) 01:46:54 INFO - ##### 01:46:54 INFO - ##### 01:46:54 INFO - ##### Running populate-webroot step. 01:46:54 INFO - ##### 01:46:54 INFO - Running pre-action listener: _resource_record_pre_action 01:46:54 INFO - Running main action method: populate_webroot 01:46:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:54 INFO - '--tppagecycles', 01:46:54 INFO - '7'], 01:46:54 INFO - 'tests': ['tsvgm']}}, 01:46:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:46:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:46:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:46:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['damp', 'tps']}, 01:46:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'tests': ['damp', 'tps']}, 01:46:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['dromaeo_dom']}, 01:46:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['basic_compositor_video']}, 01:46:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:46:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['a11yr', 01:46:54 INFO - 'ts_paint', 01:46:54 INFO - 'tpaint', 01:46:54 INFO - 'sessionrestore', 01:46:54 INFO - 'sessionrestore_no_auto_restore', 01:46:54 INFO - 'tabpaint']}, 01:46:54 INFO - 'other-e10s': {'tests': ['a11yr', 01:46:54 INFO - 'ts_paint', 01:46:54 INFO - 'tpaint', 01:46:54 INFO - 'sessionrestore', 01:46:54 INFO - 'sessionrestore_no_auto_restore', 01:46:54 INFO - 'tabpaint']}, 01:46:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:46:54 INFO - 'ts_paint', 01:46:54 INFO - 'tpaint', 01:46:54 INFO - 'sessionrestore', 01:46:54 INFO - 'sessionrestore_no_auto_restore', 01:46:54 INFO - 'tabpaint']}, 01:46:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:46:54 INFO - 'ts_paint', 01:46:54 INFO - 'tpaint', 01:46:54 INFO - 'sessionrestore', 01:46:54 INFO - 'sessionrestore_no_auto_restore', 01:46:54 INFO - 'tabpaint']}, 01:46:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['a11yr', 01:46:54 INFO - 'ts_paint', 01:46:54 INFO - 'tpaint', 01:46:54 INFO - 'sessionrestore', 01:46:54 INFO - 'sessionrestore_no_auto_restore', 01:46:54 INFO - 'tabpaint']}, 01:46:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['a11yr', 01:46:54 INFO - 'ts_paint', 01:46:54 INFO - 'tpaint', 01:46:54 INFO - 'sessionrestore', 01:46:54 INFO - 'sessionrestore_no_auto_restore', 01:46:54 INFO - 'tabpaint']}, 01:46:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['tsvgx', 01:46:54 INFO - 'tsvgr_opacity', 01:46:54 INFO - 'tart', 01:46:54 INFO - 'tscrollx', 01:46:54 INFO - 'cart']}, 01:46:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:46:54 INFO - 'tsvgr_opacity', 01:46:54 INFO - 'tart', 01:46:54 INFO - 'tscrollx', 01:46:54 INFO - 'cart']}, 01:46:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'talos_options': ['--disable-e10s'], 01:46:54 INFO - 'tests': ['tp5o']}, 01:46:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'tests': ['tp5o']}, 01:46:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'talos_options': ['--disable-e10s', 01:46:54 INFO - '--xperf_path', 01:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:54 INFO - 'tests': ['tp5n']}, 01:46:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:54 INFO - 'talos_options': ['--xperf_path', 01:46:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:54 INFO - 'tests': ['tp5n']}}, 01:46:54 INFO - 'talos.zip': {'path': '', 01:46:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:54 INFO - Running post-action listener: _resource_record_post_action 01:46:54 INFO - ##### 01:46:54 INFO - ##### Finished populate-webroot step (success) 01:46:54 INFO - ##### 01:46:54 INFO - ##### 01:46:54 INFO - ##### Running create-virtualenv step. 01:46:54 INFO - ##### 01:46:54 INFO - Running pre-action listener: _resource_record_pre_action 01:46:54 INFO - Running main action method: create_virtualenv 01:46:54 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:54 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 01:46:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:54 INFO - Using real prefix '/usr' 01:46:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:54 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:56 INFO - Installing pip.................done. 01:46:56 INFO - Return code: 0 01:46:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46: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')]} 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46: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')]} 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:56 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:46:56 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 01:46:56 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 01:46:56 INFO - Using env: {'DISPLAY': ':0', 01:46:56 INFO - 'HOME': '/home/cltbld', 01:46:56 INFO - 'LANG': 'en_US.UTF-8', 01:46:56 INFO - 'LANGUAGE': 'en_US:en', 01:46:56 INFO - 'LOGNAME': 'cltbld', 01:46:56 INFO - 'MAIL': '/var/mail/cltbld', 01:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:56 INFO - 'MOZ_NO_REMOTE': '1', 01:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:56 INFO - 'NO_EM_RESTART': '1', 01:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:56 INFO - 'PWD': '/builds/slave/test', 01:46:56 INFO - 'SHELL': '/bin/bash', 01:46:56 INFO - 'SHLVL': '1', 01:46:56 INFO - 'TERM': 'linux', 01:46:56 INFO - 'TMOUT': '86400', 01:46:56 INFO - 'USER': 'cltbld', 01:46:56 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:56 INFO - '_': '/tools/buildbot/bin/python'} 01:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:57 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 01:46:57 INFO - Cleaning up... 01:46:57 INFO - Return code: 0 01:46:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:46:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:46:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:46:57 INFO - Using env: {'DISPLAY': ':0', 01:46:57 INFO - 'HOME': '/home/cltbld', 01:46:57 INFO - 'LANG': 'en_US.UTF-8', 01:46:57 INFO - 'LANGUAGE': 'en_US:en', 01:46:57 INFO - 'LOGNAME': 'cltbld', 01:46:57 INFO - 'MAIL': '/var/mail/cltbld', 01:46:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:57 INFO - 'MOZ_NO_REMOTE': '1', 01:46:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:57 INFO - 'NO_EM_RESTART': '1', 01:46:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:57 INFO - 'PWD': '/builds/slave/test', 01:46:57 INFO - 'SHELL': '/bin/bash', 01:46:57 INFO - 'SHLVL': '1', 01:46:57 INFO - 'TERM': 'linux', 01:46:57 INFO - 'TMOUT': '86400', 01:46:57 INFO - 'USER': 'cltbld', 01:46:57 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:46:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:57 INFO - '_': '/tools/buildbot/bin/python'} 01:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:57 INFO - Downloading/unpacking psutil>=3.1.1 01:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:59 INFO - Installing collected packages: psutil 01:46:59 INFO - Running setup.py install for psutil 01:46:59 INFO - building 'psutil._psutil_linux' extension 01:46:59 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 01:46:59 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 01:46:59 INFO - building 'psutil._psutil_posix' extension 01:46:59 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 01:46:59 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 01:46:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:59 INFO - Successfully installed psutil 01:46:59 INFO - Cleaning up... 01:46:59 INFO - Return code: 0 01:46:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:46:59 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')]} 01:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:59 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')]} 01:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:59 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:46:59 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 01:46:59 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 01:46:59 INFO - Using env: {'DISPLAY': ':0', 01:46:59 INFO - 'HOME': '/home/cltbld', 01:46:59 INFO - 'LANG': 'en_US.UTF-8', 01:46:59 INFO - 'LANGUAGE': 'en_US:en', 01:46:59 INFO - 'LOGNAME': 'cltbld', 01:46:59 INFO - 'MAIL': '/var/mail/cltbld', 01:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:59 INFO - 'MOZ_NO_REMOTE': '1', 01:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:59 INFO - 'NO_EM_RESTART': '1', 01:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:59 INFO - 'PWD': '/builds/slave/test', 01:46:59 INFO - 'SHELL': '/bin/bash', 01:46:59 INFO - 'SHLVL': '1', 01:46:59 INFO - 'TERM': 'linux', 01:46:59 INFO - 'TMOUT': '86400', 01:46:59 INFO - 'USER': 'cltbld', 01:46:59 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:59 INFO - '_': '/tools/buildbot/bin/python'} 01:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:47:02 INFO - Installing collected packages: mozsystemmonitor 01:47:02 INFO - Running setup.py install for mozsystemmonitor 01:47:02 INFO - Successfully installed mozsystemmonitor 01:47:02 INFO - Cleaning up... 01:47:02 INFO - Return code: 0 01:47:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:47:02 INFO - Using env: {'DISPLAY': ':0', 01:47:02 INFO - 'HOME': '/home/cltbld', 01:47:02 INFO - 'LANG': 'en_US.UTF-8', 01:47:02 INFO - 'LANGUAGE': 'en_US:en', 01:47:02 INFO - 'LOGNAME': 'cltbld', 01:47:02 INFO - 'MAIL': '/var/mail/cltbld', 01:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:02 INFO - 'MOZ_NO_REMOTE': '1', 01:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:02 INFO - 'NO_EM_RESTART': '1', 01:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:02 INFO - 'PWD': '/builds/slave/test', 01:47:02 INFO - 'SHELL': '/bin/bash', 01:47:02 INFO - 'SHLVL': '1', 01:47:02 INFO - 'TERM': 'linux', 01:47:02 INFO - 'TMOUT': '86400', 01:47:02 INFO - 'USER': 'cltbld', 01:47:02 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:02 INFO - '_': '/tools/buildbot/bin/python'} 01:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:02 INFO - Downloading/unpacking jsonschema==2.5.1 01:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:47:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:47:04 INFO - warning: no files found matching '*.txt' 01:47:04 INFO - no previously-included directories found matching 'build' 01:47:04 INFO - no previously-included directories found matching 'dist' 01:47:04 INFO - no previously-included directories found matching '.git*' 01:47:04 INFO - Installing collected packages: jsonschema, functools32 01:47:04 INFO - Running setup.py install for functools32 01:47:04 INFO - warning: no files found matching '*.txt' 01:47:04 INFO - no previously-included directories found matching 'build' 01:47:04 INFO - no previously-included directories found matching 'dist' 01:47:04 INFO - no previously-included directories found matching '.git*' 01:47:04 INFO - Successfully installed jsonschema functools32 01:47:04 INFO - Cleaning up... 01:47:04 INFO - Return code: 0 01:47:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:04 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:04 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 01:47:04 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 01:47:04 INFO - Using env: {'DISPLAY': ':0', 01:47:04 INFO - 'HOME': '/home/cltbld', 01:47:04 INFO - 'LANG': 'en_US.UTF-8', 01:47:04 INFO - 'LANGUAGE': 'en_US:en', 01:47:04 INFO - 'LOGNAME': 'cltbld', 01:47:04 INFO - 'MAIL': '/var/mail/cltbld', 01:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:04 INFO - 'MOZ_NO_REMOTE': '1', 01:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:04 INFO - 'NO_EM_RESTART': '1', 01:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:04 INFO - 'PWD': '/builds/slave/test', 01:47:04 INFO - 'SHELL': '/bin/bash', 01:47:04 INFO - 'SHLVL': '1', 01:47:04 INFO - 'TERM': 'linux', 01:47:04 INFO - 'TMOUT': '86400', 01:47:04 INFO - 'USER': 'cltbld', 01:47:04 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:04 INFO - '_': '/tools/buildbot/bin/python'} 01:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:06 INFO - Downloading blobuploader-1.2.4.tar.gz 01:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:47:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:47:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:07 INFO - Downloading docopt-0.6.1.tar.gz 01:47:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:47:07 INFO - Installing collected packages: blobuploader, requests, docopt 01:47:07 INFO - Running setup.py install for blobuploader 01:47:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:47:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:47:07 INFO - Running setup.py install for requests 01:47:08 INFO - Running setup.py install for docopt 01:47:08 INFO - Successfully installed blobuploader requests docopt 01:47:08 INFO - Cleaning up... 01:47:08 INFO - Return code: 0 01:47:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:08 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:08 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 01:47:08 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 01:47:08 INFO - Using env: {'DISPLAY': ':0', 01:47:08 INFO - 'HOME': '/home/cltbld', 01:47:08 INFO - 'LANG': 'en_US.UTF-8', 01:47:08 INFO - 'LANGUAGE': 'en_US:en', 01:47:08 INFO - 'LOGNAME': 'cltbld', 01:47:08 INFO - 'MAIL': '/var/mail/cltbld', 01:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:08 INFO - 'MOZ_NO_REMOTE': '1', 01:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:08 INFO - 'NO_EM_RESTART': '1', 01:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:08 INFO - 'PWD': '/builds/slave/test', 01:47:08 INFO - 'SHELL': '/bin/bash', 01:47:08 INFO - 'SHLVL': '1', 01:47:08 INFO - 'TERM': 'linux', 01:47:08 INFO - 'TMOUT': '86400', 01:47:08 INFO - 'USER': 'cltbld', 01:47:08 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:08 INFO - '_': '/tools/buildbot/bin/python'} 01:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:08 INFO - Running setup.py (path:/tmp/pip-NdMnnt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:08 INFO - Running setup.py (path:/tmp/pip-0zMHNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:08 INFO - Running setup.py (path:/tmp/pip-BSvLGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:08 INFO - Running setup.py (path:/tmp/pip-rZT8oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:08 INFO - Running setup.py (path:/tmp/pip-Nd_Fn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:08 INFO - Running setup.py (path:/tmp/pip-b0AfI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:08 INFO - Running setup.py (path:/tmp/pip-OYyg9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:08 INFO - Running setup.py (path:/tmp/pip-PyT9nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:09 INFO - Running setup.py (path:/tmp/pip-Za6uQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:09 INFO - Running setup.py (path:/tmp/pip-iU6KCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:09 INFO - Running setup.py (path:/tmp/pip-_ZNzjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:09 INFO - Running setup.py (path:/tmp/pip-YXSS1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:09 INFO - Running setup.py (path:/tmp/pip-qAnDHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:09 INFO - Running setup.py (path:/tmp/pip-JF1V9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:09 INFO - Running setup.py (path:/tmp/pip-c79EgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:09 INFO - Running setup.py (path:/tmp/pip-xrOzIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:09 INFO - Running setup.py (path:/tmp/pip-iC8tR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:09 INFO - Running setup.py install for manifestparser 01:47:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:47:09 INFO - Running setup.py install for mozcrash 01:47:09 INFO - Running setup.py install for mozdebug 01:47:10 INFO - Running setup.py install for mozdevice 01:47:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Running setup.py install for mozfile 01:47:10 INFO - Running setup.py install for mozhttpd 01:47:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Running setup.py install for mozinfo 01:47:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Running setup.py install for mozInstall 01:47:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Running setup.py install for mozleak 01:47:10 INFO - Running setup.py install for mozlog 01:47:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Running setup.py install for moznetwork 01:47:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Running setup.py install for mozprocess 01:47:10 INFO - Running setup.py install for mozprofile 01:47:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:47:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:47:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:47:11 INFO - Running setup.py install for mozrunner 01:47:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:47:11 INFO - Running setup.py install for mozscreenshot 01:47:11 INFO - Running setup.py install for moztest 01:47:11 INFO - Running setup.py install for mozversion 01:47:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:47:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:47:11 INFO - Cleaning up... 01:47:11 INFO - Return code: 0 01:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:11 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')]} 01:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:11 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')]} 01:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:11 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:11 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 01:47:11 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 01:47:11 INFO - Using env: {'DISPLAY': ':0', 01:47:11 INFO - 'HOME': '/home/cltbld', 01:47:11 INFO - 'LANG': 'en_US.UTF-8', 01:47:11 INFO - 'LANGUAGE': 'en_US:en', 01:47:11 INFO - 'LOGNAME': 'cltbld', 01:47:11 INFO - 'MAIL': '/var/mail/cltbld', 01:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:11 INFO - 'MOZ_NO_REMOTE': '1', 01:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:11 INFO - 'NO_EM_RESTART': '1', 01:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:11 INFO - 'PWD': '/builds/slave/test', 01:47:11 INFO - 'SHELL': '/bin/bash', 01:47:11 INFO - 'SHLVL': '1', 01:47:11 INFO - 'TERM': 'linux', 01:47:11 INFO - 'TMOUT': '86400', 01:47:11 INFO - 'USER': 'cltbld', 01:47:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:11 INFO - '_': '/tools/buildbot/bin/python'} 01:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:11 INFO - Running setup.py (path:/tmp/pip-egib2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:11 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)) 01:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:11 INFO - Running setup.py (path:/tmp/pip-oox4k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:11 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)) 01:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:11 INFO - Running setup.py (path:/tmp/pip-B74wx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:11 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)) 01:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:11 INFO - Running setup.py (path:/tmp/pip-Py1jfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:12 INFO - Running setup.py (path:/tmp/pip-y7eaNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:12 INFO - Running setup.py (path:/tmp/pip-rPrwo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:12 INFO - Running setup.py (path:/tmp/pip-3J75Et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:12 INFO - Running setup.py (path:/tmp/pip-ZGRe2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:12 INFO - Running setup.py (path:/tmp/pip-je9Xpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:12 INFO - Running setup.py (path:/tmp/pip-tyincB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:12 INFO - Running setup.py (path:/tmp/pip-9v4ron-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:12 INFO - Running setup.py (path:/tmp/pip-bECnzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:12 INFO - Running setup.py (path:/tmp/pip-38liN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:12 INFO - Running setup.py (path:/tmp/pip-bt7MUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:12 INFO - Running setup.py (path:/tmp/pip-27AmbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:12 INFO - Running setup.py (path:/tmp/pip-Fs5O7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:12 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)) 01:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:12 INFO - Running setup.py (path:/tmp/pip-CNtrGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:12 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)) 01:47:12 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)) 01:47:12 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)) 01:47:12 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)) 01:47:12 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)) 01:47:12 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)) 01:47:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:14 INFO - Downloading blessings-1.6.tar.gz 01:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:47:14 INFO - Installing collected packages: blessings 01:47:14 INFO - Running setup.py install for blessings 01:47:15 INFO - Successfully installed blessings 01:47:15 INFO - Cleaning up... 01:47:15 INFO - Return code: 0 01:47:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:47:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:15 INFO - Reading from file tmpfile_stdout 01:47:15 INFO - Current package versions: 01:47:15 INFO - argparse == 1.2.1 01:47:15 INFO - blessings == 1.6 01:47:15 INFO - blobuploader == 1.2.4 01:47:15 INFO - docopt == 0.6.1 01:47:15 INFO - functools32 == 3.2.3-2 01:47:15 INFO - jsonschema == 2.5.1 01:47:15 INFO - manifestparser == 1.1 01:47:15 INFO - mozInstall == 1.12 01:47:15 INFO - mozcrash == 0.17 01:47:15 INFO - mozdebug == 0.1 01:47:15 INFO - mozdevice == 0.48 01:47:15 INFO - mozfile == 1.2 01:47:15 INFO - mozhttpd == 0.7 01:47:15 INFO - mozinfo == 0.9 01:47:15 INFO - mozleak == 0.1 01:47:15 INFO - mozlog == 3.2 01:47:15 INFO - moznetwork == 0.27 01:47:15 INFO - mozprocess == 0.22 01:47:15 INFO - mozprofile == 0.28 01:47:15 INFO - mozrunner == 6.11 01:47:15 INFO - mozscreenshot == 0.1 01:47:15 INFO - mozsystemmonitor == 0.3 01:47:15 INFO - moztest == 0.7 01:47:15 INFO - mozversion == 1.4 01:47:15 INFO - psutil == 3.1.1 01:47:15 INFO - requests == 1.2.3 01:47:15 INFO - wsgiref == 0.1.2 01:47:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:15 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:15 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 01:47:15 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 01:47:15 INFO - Using env: {'DISPLAY': ':0', 01:47:15 INFO - 'HOME': '/home/cltbld', 01:47:15 INFO - 'LANG': 'en_US.UTF-8', 01:47:15 INFO - 'LANGUAGE': 'en_US:en', 01:47:15 INFO - 'LOGNAME': 'cltbld', 01:47:15 INFO - 'MAIL': '/var/mail/cltbld', 01:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:15 INFO - 'MOZ_NO_REMOTE': '1', 01:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:15 INFO - 'NO_EM_RESTART': '1', 01:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:15 INFO - 'PWD': '/builds/slave/test', 01:47:15 INFO - 'SHELL': '/bin/bash', 01:47:15 INFO - 'SHLVL': '1', 01:47:15 INFO - 'TERM': 'linux', 01:47:15 INFO - 'TMOUT': '86400', 01:47:15 INFO - 'USER': 'cltbld', 01:47:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:15 INFO - '_': '/tools/buildbot/bin/python'} 01:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 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)) 01:47:15 INFO - Cleaning up... 01:47:15 INFO - Return code: 0 01:47:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:15 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:15 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 01:47:15 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 01:47:15 INFO - Using env: {'DISPLAY': ':0', 01:47:15 INFO - 'HOME': '/home/cltbld', 01:47:15 INFO - 'LANG': 'en_US.UTF-8', 01:47:15 INFO - 'LANGUAGE': 'en_US:en', 01:47:15 INFO - 'LOGNAME': 'cltbld', 01:47:15 INFO - 'MAIL': '/var/mail/cltbld', 01:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:15 INFO - 'MOZ_NO_REMOTE': '1', 01:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:15 INFO - 'NO_EM_RESTART': '1', 01:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:15 INFO - 'PWD': '/builds/slave/test', 01:47:15 INFO - 'SHELL': '/bin/bash', 01:47:15 INFO - 'SHLVL': '1', 01:47:15 INFO - 'TERM': 'linux', 01:47:15 INFO - 'TMOUT': '86400', 01:47:15 INFO - 'USER': 'cltbld', 01:47:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:15 INFO - '_': '/tools/buildbot/bin/python'} 01:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:47:15 INFO - Cleaning up... 01:47:15 INFO - Return code: 0 01:47:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:15 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 0x7fc2a7f1bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a98350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', '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 01:47:15 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 01:47:15 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 01:47:15 INFO - Using env: {'DISPLAY': ':0', 01:47:15 INFO - 'HOME': '/home/cltbld', 01:47:15 INFO - 'LANG': 'en_US.UTF-8', 01:47:15 INFO - 'LANGUAGE': 'en_US:en', 01:47:15 INFO - 'LOGNAME': 'cltbld', 01:47:15 INFO - 'MAIL': '/var/mail/cltbld', 01:47:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:15 INFO - 'MOZ_NO_REMOTE': '1', 01:47:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:15 INFO - 'NO_EM_RESTART': '1', 01:47:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:15 INFO - 'PWD': '/builds/slave/test', 01:47:15 INFO - 'SHELL': '/bin/bash', 01:47:15 INFO - 'SHLVL': '1', 01:47:15 INFO - 'TERM': 'linux', 01:47:15 INFO - 'TMOUT': '86400', 01:47:15 INFO - 'USER': 'cltbld', 01:47:15 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:15 INFO - '_': '/tools/buildbot/bin/python'} 01:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:15 INFO - Downloading/unpacking flake8 01:47:15 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 01:47:15 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 01:47:15 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 01:47:15 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 01:47:15 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 01:47:15 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 01:47:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:47:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:47:17 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 01:47:17 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 01:47:17 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 01:47:17 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 01:47:17 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 01:47:17 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 01:47:18 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:47:18 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:18 INFO - no previously-included directories found matching 'docs/_build' 01:47:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:47:18 INFO - Running setup.py install for pep8 01:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:18 INFO - no previously-included directories found matching 'docs/_build' 01:47:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:47:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:47:18 INFO - Cleaning up... 01:47:18 INFO - Return code: 0 01:47:18 INFO - Running post-action listener: _resource_record_post_action 01:47:18 INFO - Running post-action listener: _start_resource_monitoring 01:47:18 INFO - Starting resource monitoring. 01:47:18 INFO - ##### 01:47:18 INFO - ##### Finished create-virtualenv step (success) 01:47:18 INFO - ##### 01:47:18 INFO - ##### 01:47:18 INFO - ##### Running install step. 01:47:18 INFO - ##### 01:47:18 INFO - Running pre-action listener: _resource_record_pre_action 01:47:18 INFO - Running main action method: install 01:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:19 INFO - Reading from file tmpfile_stdout 01:47:19 INFO - Detecting whether we're running mozinstall >=1.0... 01:47:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:47:19 INFO - Reading from file tmpfile_stdout 01:47:19 INFO - Output received: 01:47:19 INFO - Usage: mozinstall [options] installer 01:47:19 INFO - Options: 01:47:19 INFO - -h, --help show this help message and exit 01:47:19 INFO - -d DEST, --destination=DEST 01:47:19 INFO - Directory to install application into. [default: 01:47:19 INFO - "/builds/slave/test"] 01:47:19 INFO - --app=APP Application being installed. [default: firefox] 01:47:19 INFO - mkdir: /builds/slave/test/build/application 01:47:19 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'] 01:47:19 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 01:47:35 INFO - Reading from file tmpfile_stdout 01:47:35 INFO - Output received: 01:47:35 INFO - /builds/slave/test/build/application/firefox/firefox 01:47:35 INFO - Running post-action listener: _resource_record_post_action 01:47:35 INFO - ##### 01:47:35 INFO - ##### Finished install step (success) 01:47:35 INFO - ##### 01:47:35 INFO - ##### 01:47:35 INFO - ##### Running run-tests step. 01:47:35 INFO - ##### 01:47:35 INFO - Running pre-action listener: _resource_record_pre_action 01:47:35 INFO - Running main action method: run_tests 01:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:47:35 INFO - Python 2.7.3 01:47:35 INFO - Return code: 0 01:47:35 INFO - grabbing minidump binary from tooltool 01:47: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')]} 01:47:35 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 0x1b271c0>, '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 0x1b280c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b28550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:47:35 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 01:47:35 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 01:47:35 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 01:47:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:35 INFO - Return code: 0 01:47:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:47:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:47:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:47:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:47:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:47:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:47:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:47:36 INFO - Return code: 0 01:47:36 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/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 01:47:36 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/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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 01:47:36 INFO - Using env: {'DISPLAY': ':0', 01:47:36 INFO - 'HOME': '/home/cltbld', 01:47:36 INFO - 'LANG': 'en_US.UTF-8', 01:47:36 INFO - 'LANGUAGE': 'en_US:en', 01:47:36 INFO - 'LOGNAME': 'cltbld', 01:47:36 INFO - 'MAIL': '/var/mail/cltbld', 01:47:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:36 INFO - 'MOZ_NO_REMOTE': '1', 01:47:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:36 INFO - 'NO_EM_RESTART': '1', 01:47:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:36 INFO - 'PWD': '/builds/slave/test', 01:47:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:36 INFO - 'SHELL': '/bin/bash', 01:47:36 INFO - 'SHLVL': '1', 01:47:36 INFO - 'TERM': 'linux', 01:47:36 INFO - 'TMOUT': '86400', 01:47:36 INFO - 'USER': 'cltbld', 01:47:36 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166', 01:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:36 INFO - '_': '/tools/buildbot/bin/python'} 01:47:36 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/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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 01:47:36 INFO - mozversion application_buildid: 20160621004800 01:47:36 INFO - mozversion application_changeset: be179bb8c58ff829b3c81cbc203833686dd3739e 01:47:36 INFO - mozversion application_display_name: Nightly 01:47:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:36 INFO - mozversion application_name: Firefox 01:47:36 INFO - mozversion application_remotingname: firefox 01:47:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:47:36 INFO - mozversion application_vendor: Mozilla 01:47:36 INFO - mozversion application_version: 50.0a1 01:47:36 INFO - mozversion platform_buildid: 20160621004800 01:47:36 INFO - mozversion platform_changeset: be179bb8c58ff829b3c81cbc203833686dd3739e 01:47:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:47:36 INFO - mozversion platform_version: 50.0a1 01:47:36 INFO - using testdate: 1466498856 01:47:36 INFO - actual date: 1466498856 01:47:36 INFO - starting webserver on 'localhost:41409' 01:47:36 INFO - SUITE-START | Running 2 tests 01:47:36 INFO - TEST-START | dromaeo_css 01:47:36 INFO - operating with platform_type : linux_ 01:47:36 INFO - Initialising browser for dromaeo_css test... 01:47:36 INFO - TEST-INFO | started process 12984 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQThpao/profile http://localhost:41409/getInfo.html) 01:47:42 INFO - PROCESS | 12984 | __metrics Screen width/height:1600/1200 01:47:42 INFO - PROCESS | 12984 | colorDepth:24 01:47:42 INFO - PROCESS | 12984 | Browser inner width/height: 1024/697 01:47:42 INFO - PROCESS | 12984 | __metrics 01:47:42 ERROR - PROCESS | 12984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 01:47:43 INFO - TEST-INFO | 12984: exit 0 01:47:43 INFO - Browser initialized. 01:47:43 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:43 INFO - TEST-INFO | started process 13101 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQThpao/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:55 INFO - PROCESS | 13101 | RSS: Main: 186372096 01:47:55 INFO - PROCESS | 13101 | 01:48:45 INFO - PROCESS | 13101 | 1466498925371 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] 01:50:58 INFO - PROCESS | 13101 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41409/tests/dromaeo/cssquery-ext.html) 01:50:59 INFO - PROCESS | 13101 | RSS: Main: 189509632 01:50:59 INFO - PROCESS | 13101 | 01:54:01 INFO - PROCESS | 13101 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-ext.html (next: http://localhost:41409/tests/dromaeo/cssquery-jquery.html) 01:54:01 INFO - PROCESS | 13101 | RSS: Main: 188198912 01:54:01 INFO - PROCESS | 13101 | 01:57:03 INFO - PROCESS | 13101 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41409/tests/dromaeo/cssquery-mootools.html) 01:57:04 INFO - PROCESS | 13101 | RSS: Main: 190107648 01:57:04 INFO - PROCESS | 13101 | 02:00:06 INFO - PROCESS | 13101 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41409/tests/dromaeo/cssquery-prototype.html) 02:00:06 INFO - PROCESS | 13101 | RSS: Main: 187162624 02:00:06 INFO - PROCESS | 13101 | 02:03:09 INFO - PROCESS | 13101 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41409/tests/dromaeo/cssquery-yui.html) 02:03:10 INFO - PROCESS | 13101 | RSS: Main: 189501440 02:03:10 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | Cycle 1(1): loaded http://localhost:41409/tests/dromaeo/cssquery-yui.html (next: http://localhost:41409/tests/dromaeo/cssquery-dojo.html) 02:06:12 INFO - PROCESS | 13101 | RSS: Main: 190169088 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | __start_tp_report 02:06:12 INFO - PROCESS | 13101 | _x_x_mozilla_page_load 02:06:12 INFO - PROCESS | 13101 | _x_x_mozilla_page_load_details 02:06:12 INFO - PROCESS | 13101 | |i|pagename|runs| 02:06:12 INFO - PROCESS | 13101 | |0;dojo.html;2631.2106368089576;2674.7057823639398;2690.6367640368544;2695.7304269573033;2706.215197592698;4799.088173247081;4811.23020316749;4852.053849499349;4860.708357498553;4955.826546070888;4779.808807647699;4856.927146092811;4857.562819346258;4877.414710234768;4919.0653775782575;4400.427944367236;4458.041521072969;4575.885602859922;4585.862424127282;4602.14860250853;559.3117056467993;4397.252467080604;4407.801648925806;4414.381986521889;4490.932636010462;4454.042380888109;4465.732056076646;4493.303537951622;4495.5953964143055;4511.481179664348;4487.932681009787;4496.2581174106235;4502.144592527442;4505.189065968125;4550.249208880531;4397.032652816375;4430.601245887886;4449.755263460508;4452.1986042512335;4457;4786.928196077061;4847.563719265283;4876.951230487685;4909.852704418873;4979.775910084055;5168.483151684839;5172.32759741235;5201.063808514466;5202.453742357074;5255.632105752599;5222.451642577513;5255;5265.7893684252585;5272.868178295574;5323.574114070865;4921.335619691367;4931.284963680247;4933.358663373739;4937.950620493749;4938.259261110862;5216.921746173811;5306.389765177054;5346.304980352607;5370.060239458079;5384.057789886832;5110.131277682803;5148.073346797538;5154.30416893722;5161.045206636784;5162.97418512905;5212.087884620177;5217.843464696065;5227.764750586232;5278.577713782888;5323.840284791462;4990.051890140861;5064.290999260106;5109.9744501278;5129.435762066169;5201.921971170435;5120.385553733576;5123.077845987758;5149.665271757323;5155.510226528474;5157.4584668610005;4507.842225522091;4511.436070491189;4515.954840451619;4518.864434066983;4549.658775591844;3873.0317420644838;3880.5925377835483;3887.9611203888167;3909.980450097788;3923.2349691810396;4484.887877803016;4485.663575231805;4493.168763778646;4536.387587675687;4547.772611369484;5235.921461178085;5253.868653283622;5256.474352564713;5275.129603615437;5312.4156342803035;4431.977840110779;4493.842715504941;4533.591976722111;4535.931961020588;4596.4714057883775;4769.642276829251;4772.117158325721;4773.09311230865;4807.711537307773;4810.542998415145;4799.28010798383;4866.29438731389;4873.342098816756;4887.780049897692;4940.184869496637;5120.71836049006;5148.536631703165;5237.0835103857435;5249.238860365149;5267.631265811509;4890.975545122252;4907.828226012072;4909.754512274443;4916.385451818523;4978.975105124451;5145.279660847559;5157.226416037624;5185.196294574347;5194.558462530727;5203.141481655636;5177.275181474672;5195.636305458582;5212.192110222922;5276.023935571931;5283;5109.591232701449;5140.588752899685;5142.537171654569;5156.355455568054;5200.479952004769;4944.554990050912;5036.823711170238;5132.743362831919;5137.255098010843;5142.742862856917;4996.800127994839;5026;5042.193249080129;5053.772580233972;5108.770105345343;5169.276301317744;5180.300659410931;5183.870403239949;5201;5245.527902488641;4920.975395123001;4921.064997650578;5031.4213865405945;5073.213651883964;5077.3145625341585 02:06:12 INFO - PROCESS | 13101 | |1;ext.html;532.1532601389198;578.482258378751;579.7999690106915;597.0238659791243;613.7575657615239;32913.835430822845;37212.81393593028;37276.068098297525;37351.06622334443;37370;37979.43030854533;38571.614283857154;38696.41955370671;38843.22313553727;38886.8055659722;7750.5349679019155;7851.097123830776;7861.8034549136155;7864.567448790314;7881.369490440751;7677.769666910001;7780.299773020427;7836.764897053097;7836.960815195916;7860.921390786105;7798.4930979486435;7836.568988705619;7869.527828330319;7876.606169691521;7897.763067107996;7749.457537972344;7804.648790804427;7819.843603127905;7821.491603045783;7831.177726338709;7725.150233474369;7737.729179478748;7803.219678032208;7831.569263690551;7855.8036049098655;29539.85230073836;36374;36706.8164659175;36717.63282367169;36757.44863827045;2889.2632378743497;3078.830664313462;3100.98449507751;3230.3700778347998;3389.4237979543536;27555;29848.104556863327;29866;30514.237144071354;31078.378432431226;2927.297448612339;2941.2058744139176;2944.5435957426635;2996.865141068657;3025.6369235691636;242777;245479;248614;248809;249026;32614.836925815693;33478.8326058373;33532.32935341328;49577.25634115491;50158.49841501611;34384.21773604902;34755.47866782;34930.65069349274;34939.82530087333;35166.296674066376;12305.876941230652;12418;12509.49962001528;12509.56216532417;12534.623961281177;9424.246060315296;9455.29085318604;9458.763530911783;9478.099580539838;9507.809843803085;7948.324392426593;8110.756677299691;8119.75640730779;8173.7139200128895;8248.381371397169;3211.6627754085953;3235.320582677664;3243.3837570861933;3255.283837555734;3299.686529779667;908.0783005249676;921.161742814036;935.1817159985013;944.2304521814699;957.9473128977974;26623.86688066586;27857.16428507148;27862.263415219462;28091.157265282076;28155;929.2473096791621;945.7446489447948;949.1457688080783;955.1546881010356;1050.7163065972297;14866.776998345034;14953.850461495245;15059.849401505844;15144.848551514344;15205.391784328503;391532;392308;392990;394194;397454;48010.75994620074;48494.27258591124;48765;48850.26724599134;48903.51096489061;1148.3970915269551;1166.9824952625718;1177.6408195500455;1185.5376403202758;1195.6353312239676;26074;27233.86383068072;27482.725172748815;27566.5865012029;28019.159425217276;40910.59089409068;41311.38032929449;41348.379774302804;41362;41477.37783933183;319826;324278;326657;327623;328168;25477.745222548278;25578.10476633309;25629.3592660185;25639.743602563736;25758.227253182435;45208.54791452044;46106.538934610224;46509.76745116253;47240.2913956284;47738.28392574184;35764.35629742655;36367.454488183226;36610.45084323684;36899.81550092233;36931.63068369282;35908.640913591575;35931.28137437289;36024.81987590045;36245.81877090598;36296.637033629326;35656.108597285274;35672;37995.2400951985;38865.222695546494;39547.40678889876;30696.84651576728;32559.845368488684;33233.66766332403;33443.66556334405;33452.665473344954;25424.745752542236;25477.631069118685;25628.103016394336;25668.229953101436;25695.100671477157 02:06:12 INFO - PROCESS | 13101 | |2;jquery.html;369.7799809113578;372.0624027450824;376.9038895081754;386.19093000164645;390.49820980040636;15531.844681553195;16116;17124.22940967656;17190.484285471426;17211.569710757238;15939.203039847991;16297.51107466775;17185.140742962863;17360.305587776504;17393.47819565412;5061.089003979291;5202.661826981234;5241.528262456378;5254.159334506479;5286.101362768339;5115.641905066647;5210.452902445246;5238.5023422774775;5241.580673546107;5244.947550524484;4926.458089610158;5123.846284611468;5137.280780690707;5155.845324640267;5159.174532074869;5061.215511595708;5110.131277682803;5152.304438900756;5155.71643559604;5165.535101840853;4448.644108471314;4616.53834616539;4618.838340658061;4622.14490319292;4625.676202665814;19551.413457596296;19831.80168198314;20636.69044964327;20737.5852482951;20748.377548673565;1710.9144542772813;1875.7467741854812;1884.3875740384292;2035.297822251321;2299.3331933739196;9230.58462369195;9337.486438245895;9433.622655093788;9456.14894659484;9466.952665236699;1756.6486702659392;1804.3684710351404;1813.9818601813945;1846.4645252876649;1850.2229063793238;45530.54469455296;62528.374716253165;68081.65959170222;69126.65436672834;69986.65006674985;9655.179309758749;9769.658061967797;9790.951045244728;10052.145567626687;10525.789484210272;13203.669908252179;13394.93302533481;13412.12821166621;13470.93264533671;13594.93202533981;6455.160829092188;6510.511711621647;6732.427743641845;6827.146606674166;6851.657417129124;6164.630122192682;6260.874782504325;6415.230172379344;6425.710843012076;6454.579992401664;4126.979365103215;4183.163367326547;4186.6859985501205;4230.450041494586;4256.659467242614;1807.4216250799882;1847.7505536752635;1849.2510533234063;1852.6665200263812;1857.2942281932778;819.8524265632243;883.739296907401;884.6107712606562;890.3411475508077;928.8095940332215;16348.75476867848;16405.261763220682;16951.915240423965;17180.656386872193;17191.398301059402;834.7370578267826;856.0925419055696;860.7159637319669;872.6553011560399;875.0461996423928;9502.334836561513;9585.712428627152;9661.951690241503;9804;9890;388939;410669;411538;412195;414253;51108;52857.47142528602;82390;84028.57985710033;88432.5578372104;924.9213816825511;936.9765755856158;952.0717300631828;982.332014230316;986.5954958466995;15705.136217508147;15933.601659958595;15963.122028288555;16013.519594412186;16269.67460650804;36995.26009479849;37673.43489847709;37754.43368349532;37961.62038379581;37996.430053549775;46198.7690061561;46669.29996049994;46731.29903051525;52869.471305287996;55418;6962.860742785015;7229.204787473269;7272.345488906024;7315.268473152642;7393.55638661682;11090.5563777448;11868.703282418008;11902.940485297519;11970.521179153086;12087.69780755453;9866.408015519091;9875.901240987498;10166;10181.287309888237;10205.591776328863;10040.14658754014;10045.49772511386;10046.447445390573;10130.544125514221;10184.745381365525;10289.382637041801;10568.95544156343;10608.522616482123;10617.787644247226;10642.148628109888;7518.097828260644;7577.204393538819;7628.084629844454;7701.730439434593;7734.922650773646;10154.035366640157;10290.228232882713;10322.2258330624;10477.633282835064;10498.265121441425 02:06:12 INFO - PROCESS | 13101 | |3;mootools.html;1346.252829679528;1423.4448565059624;1448.23967417106;1597.2812234494481;1650.4800987688884;6572.704228309725;7270.4910656254015;7283.635818209094;7766.72816451425;7786.377089832814;7246;7520.736774212904;7538;7557.69769209231;7586.279303466175;2129.244118337991;2149.9140034398683;2150.956980860382;2167.0140086260794;2177.7822217778253;2108.8523803333774;2137.7969092936223;2170.0994087453687;2184.464806122502;2189.4635814225535;2158.98920505398;2162.362103179566;2163.3834357208198;2168.577127460146;2172.5329054253334;2061.4124974382303;2071.388940262626;2072.6580114281123;2075.2114196605194;2080.3134965461363;2049.4876280929766;2065.4216819290623;2073.6993135995194;2089.5686454778524;2096.895155242232;7528.698852045912;7587.393008559302;7611.885821712679;7622.923770762277;7629.923700763033;4361.193179261847;4418.403515525395;4452.532484089156;4493.348464472666;4495.640348772123;2727.2500062482777;2746.725327467257;2748.038186634662;2750.3674154944274;2752.270648278208;852.5609311204735;869.6260607938584;871.7166920750782;874.1389731114847;892.2326798952895;10015.799684006279;10071.09360157582;10078.445685487295;10114.54484548197;10119.544620492095;3913.745606535566;3950.20995800841;4025.718199725991;4037.6769858411258;4045.696572757055;8699.869501957475;8726.86909696355;8727.781805454915;8731.650733970697;8740.606672699743;4485.529019452975;4493.415855938707;4499.302608095751;4500.8649740507835;4504.61710754583;3594.6225646307284;3962.445257663929;4070.409790580349;4073.6333729964445;4180.163967206571;3492.2491664292297;3537.663921927413;3632.400653892078;3639.3994990826745;3719.3305205062807;1140.1790710688292;1156.9363684997406;1162.2793867802018;1165.9941700291613;1166.8833116688263;819.995900020496;820.2581926514399;834.0533494483805;837.6021389839777;845.0915266088979;5032.748362581856;5211.687298762086;5310.840674779763;5351.25082488452;5362.8659283517445;864.4251572704208;890.7862113092941;893.7363477774072;922.3543519536352;927.2813569483704;3416.8598849130813;3503.1373598596447;3543.6810687037773;3547.7516573839584;3569.446735755962;9065.229455496357;9246.352755307198;9371.859422108673;9414.811703765887;9451.432914025181;9285.953570232106;9321;9328.44029358227;9330.1136392044;9353.345265831462;7071.328223818729;7187.64061796908;7198.748043818441;7209.062821833233;7223.277672232734;4906.681065730716;5025.623078269217;5131.538161565477;5176.197689358156;5219.2953951216095;8395.748127556182;8436.367272454469;8590.91409085901;8591.355648326526;8713.041565427671;8512;8804.427712198687;8870.334724895787;8886.111388861062;8888.688895888612;5626.803061892814;6234.470070044097;6234.9688251558455;6303.684815759286;6305.716242768995;7462.067241594801;7464.589447580435;7493.662785174789;7507.174210836913;7513.849723005618;6560.44236239925;6705.966470167618;6746.966265168643;6756.425703815231;6815.897761533482;6390.5526613136635;6396.936030639634;6416.069669897932;6428.228612566522;6438.742450301936;6121.234845644294;6181.227346581677;6185.350538193425;6204.100405441276;6225.190725205694;4276.337167739005;4454.443194600675;4457.621102206349;4470.619997300266;4500.729956202638;4431.313146462304;4478.149151661174;4499.820007199806;4501.752403617701;4529.84145554904 02:06:12 INFO - PROCESS | 13101 | |4;prototype.html;298.72964966705126;299.44602485402004;300.99699003009977;308.11263560944474;309.561969812715;5265.18389649604;5273.34083239595;5276.841694749154;5282.154855223165;5300.992811365838;5127.564157046656;5136.845894623168;5145.276332428641;5165.896682066356;5179.171332586787;3771.3023090728166;3864.8260828262655;3935.091480631891;3956.7428117172435;3977.548194908852;3974.4237085622567;3992.900177495557;4005.3391190453685;4022.7385219960756;4022.9798851005703;3983.0639799647206;3983.741056831311;3987.2224916141363;3991.1219531702977;3991.8602848900296;3699.426588878728;3948.7097483459524;3948.7630742155275;3991.263800246902;3991.642841433912;3434.3131373725355;3435.9828200858838;3444.3800115979116;3447.207142357247;3455.032590874559;5003.924941125886;5052.166392545226;5055.368078990126;5057.49425057495;5078.61910356721;4294.677899157545;4537.546245375469;4544.840930567414;4556.951901062741;4563.703359281636;5423.728813559345;5431.755570999315;5433.755481003364;5435.592330575183;5456.372517160537;3777.1501412182315;3777.6788972937334;3787.9810600947094;3795.203007368456;3817.866374676873;5353.518183363477;5611.186377975211;5660.943390566083;5663.546916246691;5673.3475650299915;3821.293060783764;3828.693704503633;3847.9230415391535;3861.864834730771;3865.9806700966315;3921.705872059607;3932.724709270381;3947.763134211899;3949.7037722170953;3951.9802400988387;4496.213162696515;4524.411826462605;4539.364488971547;4540;4554.041762042288;5106.361704786902;5353.652012619167;5363.570914326922;5405.486478784509;5408.35045311176;1339.9464021439032;1346.9797953030713;1351.196038357176;1352.817369655084;1352.891768658505;835.4110352201683;857.2456238510072;876.3077169036517;877.9429337093069;939.1219210038636;4576.633869290449;4606.355110284563;4640.213517795605;4666.556677115668;4706.905861882743;5448.83653490396;5469.206964990134;5505;5560.165975103767;5586.13414920688;4558.817647294138;4660.86017419478;4737.194676904935;4743.667943244009;4755.809767609326;2941.470535303666;2952.763778897683;2956.2609347663083;2958.290010397489;2960.2155428811384;5135.281060651511;5139.794408223629;5142.922856157161;5149.613778966517;5156.20078887773;5531.557475401958;5541.668515532971;5627;5658.868226354745;5704.258446401941;5137.717425541631;5165.974170129125;5185.766640501187;5201.765920533585;5221.765020574007;5508;5520.66875987442;5524.1989911463415;5529.281193444987;5609.6073274872;5150.48495150482;5455.208994695826;5464.23500709893;5479.534209605614;5487.945120548743;5155.381354237516;5173.611979101507;5175.637705360588;5240.318758561362;5244.449332819999;4005.097578650118;4009;4030.5163380394542;4041.474608300902;4043.5147782266317;5358.598105142052;5430.456954304538;5442.9930462864495;5471.835844924659;5490.368607610176;5270.762815673227;5328.866778330417;5336.466353364633;5338.38608560005;5365.490278423544;5167.379914410144;5265.4320067942335;5306.442823503477;5328.307320048369;5355.384130824849;5232.843014709565;5250.448702886142;5268.367795864521;5271.525562699376;5299.920501192562;5189.974050129726;5258.526732594085;5419.756110974937;5435.673859568438;5486.972565137149;5299.576033917355;5319.654222475527;5324.2580071262555;5327.813526526553;5384.869177472775 02:06:12 INFO - PROCESS | 13101 | |5;yui.html;642.6915080761235;655.1352215076101;670.8993650952359;728.9526180798248;744.3040756892306;12058.216215945957;13215.867841321584;13372.933135334333;13421.463141474354;13558.050936434454;12748.235105893653;12777.55278565248;12886.742265154691;12896.613101606967;12968;625.9280182778994;746.5968377076372;770.2451597434517;774.094309657699;791.70311133325;784.1022029775903;787.5117427195147;788.8343447875953;789.5933594198992;791.5409062743595;832.142892820396;838.714836955435;839.9202075802789;840.5419046619606;841.4908980067063;820.9794755131139;822.5517093184229;824.8597738384459;826.3141592478229;829.7096016394274;605.1890466774499;605.4339192854695;608.6500262349123;609.7073404765692;610.9389061093855;13216.801747973788;13237.73524529504;13244.867551324556;13265.668358291023;13288.26914519701;13239.73520529584;13498.392572334269;13500.189988600716;13609.11540749858;13956.72086558263;10617.097546708539;10665.306755060896;10778.19163562736;10839.13286937043;10955.671329860037;3273.3780581689402;3323;3338.582677165354;3345.6654334566592;3351.1287065362935;60444.69777651084;61023.69488152575;61055.69472152655;62069.379306207265;62755.6862215686;9640.807183856425;9824.06671366219;9984.750381240527;10173.237007224488;10238.53926573306;16955;19514.414567562995;19524.511887202934;19635.705464418046;19712.112954917062;6987.965060174666;7368.37368823656;7369.373603243785;7374.299441553044;7461.664225109883;3945.151792364598;4022.1151346703678;4029.435878976946;4047.1905618876344;4085.080856807195;2894.493463643896;2992.7456166226116;2995.311078451968;2996.9100926972224;2999.2651800309063;488.79226328810114;494.06621485392634;504.11527768766314;504.75771629617253;504.8813528820724;480.8052738640856;587.3597778421541;613.5183880653666;619.1641284266204;619.9105345116643;8092.9190708092165;8098.230668086522;8132.1867813218205;8183;8379.203975622306;571.2801869644195;598.6228675934134;603.5232166588434;621.1825218229891;638.3999040901631;3917.8236979335998;3948.447217389568;3951.4072889066297;4007.0182805212908;4038.273110840018;87607.56196218978;88491.55754221187;89509.55245223732;91131;93058.53470732739;81642.59178704068;83480.58259708663;84503.5774821122;85248;85802.57098714466;43160.352594711105;43315.56684433115;44986.77506612446;45158.54841451609;73916;7276.818079548054;7508.962455187689;7652.349550288065;7743.612819358897;7811.218878112143;43658.126837462434;44388;44679.9999999987;44680.106397872514;45126.77436612796;42870.785646072814;56042;56160;60193;60866.69566652139;10586.629467968583;10752.139828813833;10916.263044889336;11026.669199924016;11561.826572601585;12679.175853569488;13232.536861209812;13306.268155251168;13328.866711332763;13537;11787.115966302734;11861.5848445304;12452.252864828139;12567.93716031414;12698.174618649758;12119.212251203644;12147.271163730204;12189.146759726735;12288.324142172267;12415.813762793747;10627.309224900357;11347.48936297852;11670.474828632561;12043.397830108284;12435.564755233885;9400.529973501434;9847.753806154904;9872.703818885446;9886.555105020147;10199.031092046243;10182.389056656624;10311.690649280534;10392.116670082825;10413;10483.842742358718 02:06:12 INFO - PROCESS | 13101 | __end_tp_report 02:06:12 INFO - PROCESS | 13101 | __start_cc_report 02:06:12 INFO - PROCESS | 13101 | _x_x_mozilla_cycle_collect,400 02:06:12 INFO - PROCESS | 13101 | __end_cc_report 02:06:12 INFO - PROCESS | 13101 | __startTimestamp1466499972791__endTimestamp 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | ------- Summary: start ------- 02:06:12 INFO - PROCESS | 13101 | Number of tests: 6 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | [#0] dojo.html Cycles:165 Average:4806.77 Median:4940.18 stddev:607.81 (12.3%) stddev-sans-first:585.22 02:06:12 INFO - PROCESS | 13101 | Values: 2631.2 2674.7 2690.6 2695.7 2706.2 4799.1 4811.2 4852.1 4860.7 4955.8 4779.8 4856.9 4857.6 4877.4 4919.1 4400.4 4458.0 4575.9 4585.9 4602.1 559.3 4397.3 4407.8 4414.4 4490.9 4454.0 4465.7 4493.3 4495.6 4511.5 4487.9 4496.3 4502.1 4505.2 4550.2 4397.0 4430.6 4449.8 4452.2 4457.0 4786.9 4847.6 4877.0 4909.9 4979.8 5168.5 5172.3 5201.1 5202.5 5255.6 5222.5 5255.0 5265.8 5272.9 5323.6 4921.3 4931.3 4933.4 4938.0 4938.3 5216.9 5306.4 5346.3 5370.1 5384.1 5110.1 5148.1 5154.3 5161.0 5163.0 5212.1 5217.8 5227.8 5278.6 5323.8 4990.1 5064.3 5110.0 5129.4 5201.9 5120.4 5123.1 5149.7 5155.5 5157.5 4507.8 4511.4 4516.0 4518.9 4549.7 3873.0 3880.6 3888.0 3910.0 3923.2 4484.9 4485.7 4493.2 4536.4 4547.8 5235.9 5253.9 5256.5 5275.1 5312.4 4432.0 4493.8 4533.6 4535.9 4596.5 4769.6 4772.1 4773.1 4807.7 4810.5 4799.3 4866.3 4873.3 4887.8 4940.2 5120.7 5148.5 5237.1 5249.2 5267.6 4891.0 4907.8 4909.8 4916.4 4979.0 5145.3 5157.2 5185.2 5194.6 5203.1 5177.3 5195.6 5212.2 5276.0 5283.0 5109.6 5140.6 5142.5 5156.4 5200.5 4944.6 5036.8 5132.7 5137.3 5142.7 4996.8 5026.0 5042.2 5053.8 5108.8 5169.3 5180.3 5183.9 5201.0 5245.5 4921.0 4921.1 5031.4 5073.2 5077.3 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | [#1] ext.html Cycles:180 Average:46203.06 Median:36492.23 stddev:86497.59 (237.0%) stddev-sans-first:86672.27 02:06:12 INFO - PROCESS | 13101 | Values: 532.2 578.5 579.8 597.0 613.8 32913.8 37212.8 37276.1 37351.1 37370.0 37979.4 38571.6 38696.4 38843.2 38886.8 7750.5 7851.1 7861.8 7864.6 7881.4 7677.8 7780.3 7836.8 7837.0 7860.9 7798.5 7836.6 7869.5 7876.6 7897.8 7749.5 7804.6 7819.8 7821.5 7831.2 7725.2 7737.7 7803.2 7831.6 7855.8 29539.9 36374.0 36706.8 36717.6 36757.4 2889.3 3078.8 3101.0 3230.4 3389.4 27555.0 29848.1 29866.0 30514.2 31078.4 2927.3 2941.2 2944.5 2996.9 3025.6 242777.0 245479.0 248614.0 248809.0 249026.0 32614.8 33478.8 33532.3 49577.3 50158.5 34384.2 34755.5 34930.7 34939.8 35166.3 12305.9 12418.0 12509.5 12509.6 12534.6 9424.2 9455.3 9458.8 9478.1 9507.8 7948.3 8110.8 8119.8 8173.7 8248.4 3211.7 3235.3 3243.4 3255.3 3299.7 908.1 921.2 935.2 944.2 957.9 26623.9 27857.2 27862.3 28091.2 28155.0 929.2 945.7 949.1 955.2 1050.7 14866.8 14953.9 15059.8 15144.8 15205.4 391532.0 392308.0 392990.0 394194.0 397454.0 48010.8 48494.3 48765.0 48850.3 48903.5 1148.4 1167.0 1177.6 1185.5 1195.6 26074.0 27233.9 27482.7 27566.6 28019.2 40910.6 41311.4 41348.4 41362.0 41477.4 319826.0 324278.0 326657.0 327623.0 328168.0 25477.7 25578.1 25629.4 25639.7 25758.2 45208.5 46106.5 46509.8 47240.3 47738.3 35764.4 36367.5 36610.5 36899.8 36931.6 35908.6 35931.3 36024.8 36245.8 36296.6 35656.1 35672.0 37995.2 38865.2 39547.4 30696.8 32559.8 33233.7 33443.7 33452.7 25424.7 25477.6 25628.1 25668.2 25695.1 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | [#2] jquery.html Cycles:180 Average:24373.28 Median:24989.59 stddev:67066.70 (268.4%) stddev-sans-first:67230.62 02:06:12 INFO - PROCESS | 13101 | Values: 369.8 372.1 376.9 386.2 390.5 15531.8 16116.0 17124.2 17190.5 17211.6 15939.2 16297.5 17185.1 17360.3 17393.5 5061.1 5202.7 5241.5 5254.2 5286.1 5115.6 5210.5 5238.5 5241.6 5244.9 4926.5 5123.8 5137.3 5155.8 5159.2 5061.2 5110.1 5152.3 5155.7 5165.5 4448.6 4616.5 4618.8 4622.1 4625.7 19551.4 19831.8 20636.7 20737.6 20748.4 1710.9 1875.7 1884.4 2035.3 2299.3 9230.6 9337.5 9433.6 9456.1 9467.0 1756.6 1804.4 1814.0 1846.5 1850.2 45530.5 62528.4 68081.7 69126.7 69986.7 9655.2 9769.7 9791.0 10052.1 10525.8 13203.7 13394.9 13412.1 13470.9 13594.9 6455.2 6510.5 6732.4 6827.1 6851.7 6164.6 6260.9 6415.2 6425.7 6454.6 4127.0 4183.2 4186.7 4230.5 4256.7 1807.4 1847.8 1849.3 1852.7 1857.3 819.9 883.7 884.6 890.3 928.8 16348.8 16405.3 16951.9 17180.7 17191.4 834.7 856.1 860.7 872.7 875.0 9502.3 9585.7 9662.0 9804.0 9890.0 388939.0 410669.0 411538.0 412195.0 414253.0 51108.0 52857.5 82390.0 84028.6 88432.6 924.9 937.0 952.1 982.3 986.6 15705.1 15933.6 15963.1 16013.5 16269.7 36995.3 37673.4 37754.4 37961.6 37996.4 46198.8 46669.3 46731.3 52869.5 55418.0 6962.9 7229.2 7272.3 7315.3 7393.6 11090.6 11868.7 11902.9 11970.5 12087.7 9866.4 9875.9 10166.0 10181.3 10205.6 10040.1 10045.5 10046.4 10130.5 10184.7 10289.4 10569.0 10608.5 10617.8 10642.1 7518.1 7577.2 7628.1 7701.7 7734.9 10154.0 10290.2 10322.2 10477.6 10498.3 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | [#3] mootools.html Cycles:180 Average:4979.00 Median:5215.49 stddev:2763.79 (53.0%) stddev-sans-first:2758.06 02:06:12 INFO - PROCESS | 13101 | Values: 1346.3 1423.4 1448.2 1597.3 1650.5 6572.7 7270.5 7283.6 7766.7 7786.4 7246.0 7520.7 7538.0 7557.7 7586.3 2129.2 2149.9 2151.0 2167.0 2177.8 2108.9 2137.8 2170.1 2184.5 2189.5 2159.0 2162.4 2163.4 2168.6 2172.5 2061.4 2071.4 2072.7 2075.2 2080.3 2049.5 2065.4 2073.7 2089.6 2096.9 7528.7 7587.4 7611.9 7622.9 7629.9 4361.2 4418.4 4452.5 4493.3 4495.6 2727.3 2746.7 2748.0 2750.4 2752.3 852.6 869.6 871.7 874.1 892.2 10015.8 10071.1 10078.4 10114.5 10119.5 3913.7 3950.2 4025.7 4037.7 4045.7 8699.9 8726.9 8727.8 8731.7 8740.6 4485.5 4493.4 4499.3 4500.9 4504.6 3594.6 3962.4 4070.4 4073.6 4180.2 3492.2 3537.7 3632.4 3639.4 3719.3 1140.2 1156.9 1162.3 1166.0 1166.9 820.0 820.3 834.1 837.6 845.1 5032.7 5211.7 5310.8 5351.3 5362.9 864.4 890.8 893.7 922.4 927.3 3416.9 3503.1 3543.7 3547.8 3569.4 9065.2 9246.4 9371.9 9414.8 9451.4 9286.0 9321.0 9328.4 9330.1 9353.3 7071.3 7187.6 7198.7 7209.1 7223.3 4906.7 5025.6 5131.5 5176.2 5219.3 8395.7 8436.4 8590.9 8591.4 8713.0 8512.0 8804.4 8870.3 8886.1 8888.7 5626.8 6234.5 6235.0 6303.7 6305.7 7462.1 7464.6 7493.7 7507.2 7513.8 6560.4 6706.0 6747.0 6756.4 6815.9 6390.6 6396.9 6416.1 6428.2 6438.7 6121.2 6181.2 6185.4 6204.1 6225.2 4276.3 4454.4 4457.6 4470.6 4500.7 4431.3 4478.1 4499.8 4501.8 4529.8 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | [#4] prototype.html Cycles:180 Average:4448.28 Median:5141.36 stddev:1302.64 (25.3%) stddev-sans-first:1268.52 02:06:12 INFO - PROCESS | 13101 | Values: 298.7 299.4 301.0 308.1 309.6 5265.2 5273.3 5276.8 5282.2 5301.0 5127.6 5136.8 5145.3 5165.9 5179.2 3771.3 3864.8 3935.1 3956.7 3977.5 3974.4 3992.9 4005.3 4022.7 4023.0 3983.1 3983.7 3987.2 3991.1 3991.9 3699.4 3948.7 3948.8 3991.3 3991.6 3434.3 3436.0 3444.4 3447.2 3455.0 5003.9 5052.2 5055.4 5057.5 5078.6 4294.7 4537.5 4544.8 4557.0 4563.7 5423.7 5431.8 5433.8 5435.6 5456.4 3777.2 3777.7 3788.0 3795.2 3817.9 5353.5 5611.2 5660.9 5663.5 5673.3 3821.3 3828.7 3847.9 3861.9 3866.0 3921.7 3932.7 3947.8 3949.7 3952.0 4496.2 4524.4 4539.4 4540.0 4554.0 5106.4 5353.7 5363.6 5405.5 5408.4 1339.9 1347.0 1351.2 1352.8 1352.9 835.4 857.2 876.3 877.9 939.1 4576.6 4606.4 4640.2 4666.6 4706.9 5448.8 5469.2 5505.0 5560.2 5586.1 4558.8 4660.9 4737.2 4743.7 4755.8 2941.5 2952.8 2956.3 2958.3 2960.2 5135.3 5139.8 5142.9 5149.6 5156.2 5531.6 5541.7 5627.0 5658.9 5704.3 5137.7 5166.0 5185.8 5201.8 5221.8 5508.0 5520.7 5524.2 5529.3 5609.6 5150.5 5455.2 5464.2 5479.5 5487.9 5155.4 5173.6 5175.6 5240.3 5244.4 4005.1 4009.0 4030.5 4041.5 4043.5 5358.6 5430.5 5443.0 5471.8 5490.4 5270.8 5328.9 5336.5 5338.4 5365.5 5167.4 5265.4 5306.4 5328.3 5355.4 5232.8 5250.4 5268.4 5271.5 5299.9 5190.0 5258.5 5419.8 5435.7 5487.0 5299.6 5319.7 5324.3 5327.8 5384.9 02:06:12 INFO - PROCESS | 13101 | 02:06:12 INFO - PROCESS | 13101 | [#5] yui.html Cycles:180 Average:16724.76 Median:45056.77 stddev:23074.15 (51.2%) stddev-sans-first:23107.28 02:06:12 INFO - PROCESS | 13101 | Values: 642.7 655.1 670.9 729.0 744.3 12058.2 13215.9 13372.9 13421.5 13558.1 12748.2 12777.6 12886.7 12896.6 12968.0 625.9 746.6 770.2 774.1 791.7 784.1 787.5 788.8 789.6 791.5 832.1 838.7 839.9 840.5 841.5 821.0 822.6 824.9 826.3 829.7 605.2 605.4 608.7 609.7 610.9 13216.8 13237.7 13244.9 13265.7 13288.3 13239.7 13498.4 13500.2 13609.1 13956.7 10617.1 10665.3 10778.2 10839.1 10955.7 3273.4 3323.0 3338.6 3345.7 3351.1 60444.7 61023.7 61055.7 62069.4 62755.7 9640.8 9824.1 9984.8 10173.2 10238.5 16955.0 19514.4 19524.5 19635.7 19712.1 6988.0 7368.4 7369.4 7374.3 7461.7 3945.2 4022.1 4029.4 4047.2 4085.1 2894.5 2992.7 2995.3 2996.9 2999.3 488.8 494.1 504.1 504.8 504.9 480.8 587.4 613.5 619.2 619.9 8092.9 8098.2 8132.2 8183.0 8379.2 571.3 598.6 603.5 621.2 638.4 3917.8 3948.4 3951.4 4007.0 4038.3 87607.6 88491.6 89509.6 91131.0 93058.5 81642.6 83480.6 84503.6 85248.0 85802.6 43160.4 43315.6 44986.8 45158.5 73916.0 7276.8 7509.0 7652.3 7743.6 7811.2 43658.1 44388.0 44680.0 44680.1 45126.8 42870.8 56042.0 56160.0 60193.0 60866.7 10586.6 10752.1 10916.3 11026.7 11561.8 12679.2 13232.5 13306.3 13328.9 13537.0 11787.1 11861.6 12452.3 12567.9 12698.2 12119.2 12147.3 12189.1 12288.3 12415.8 10627.3 11347.5 11670.5 12043.4 12435.6 9400.5 9847.8 9872.7 9886.6 10199.0 10182.4 10311.7 10392.1 10413.0 10483.8 02:06:12 INFO - PROCESS | 13101 | -------- Summary: end -------- 02:06:12 INFO - PROCESS | 13101 | 02:06:13 INFO - TEST-INFO | 13101: exit 0 02:06:13 INFO - TEST-OK | dromaeo_css | took 1117074ms 02:06:13 INFO - TEST-START | kraken 02:06:13 INFO - operating with platform_type : linux_ 02:06:13 INFO - Initialising browser for kraken test... 02:06:13 INFO - TEST-INFO | started process 13338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvjfMwT/profile http://localhost:41409/getInfo.html) 02:06:18 INFO - PROCESS | 13338 | __metrics Screen width/height:1600/1200 02:06:18 INFO - PROCESS | 13338 | colorDepth:24 02:06:18 INFO - PROCESS | 13338 | Browser inner width/height: 1024/697 02:06:18 INFO - PROCESS | 13338 | __metrics 02:06:19 ERROR - PROCESS | 13338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 02:06:20 INFO - TEST-INFO | 13338: exit 0 02:06:20 INFO - Browser initialized. 02:06:20 INFO - Running cycle 1/1 for kraken test... 02:06:20 INFO - TEST-INFO | started process 13456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvjfMwT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:32 INFO - PROCESS | 13456 | RSS: Main: 185802752 02:06:32 INFO - PROCESS | 13456 | 02:06:35 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:36 INFO - PROCESS | 13456 | RSS: Main: 191315968 02:06:36 INFO - PROCESS | 13456 | 02:06:38 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-dft) 02:06:39 INFO - PROCESS | 13456 | RSS: Main: 190824448 02:06:39 INFO - PROCESS | 13456 | 02:06:42 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-fft) 02:06:43 INFO - PROCESS | 13456 | RSS: Main: 186380288 02:06:43 INFO - PROCESS | 13456 | 02:06:45 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41409/tests/kraken/driver.html?testName=audio-oscillator) 02:06:45 INFO - PROCESS | 13456 | RSS: Main: 187015168 02:06:45 INFO - PROCESS | 13456 | 02:06:48 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:48 INFO - PROCESS | 13456 | RSS: Main: 187641856 02:06:48 INFO - PROCESS | 13456 | 02:06:51 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41409/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:52 INFO - PROCESS | 13456 | RSS: Main: 188018688 02:06:52 INFO - PROCESS | 13456 | 02:06:56 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41409/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:56 INFO - PROCESS | 13456 | RSS: Main: 185606144 02:06:56 INFO - PROCESS | 13456 | 02:06:59 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41409/tests/kraken/driver.html?testName=json-parse-financial) 02:07:00 INFO - PROCESS | 13456 | RSS: Main: 187039744 02:07:00 INFO - PROCESS | 13456 | 02:07:01 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:07:02 INFO - PROCESS | 13456 | RSS: Main: 187289600 02:07:02 INFO - PROCESS | 13456 | 02:07:04 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:07:05 INFO - PROCESS | 13456 | RSS: Main: 187056128 02:07:05 INFO - PROCESS | 13456 | 02:07:07 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:07:08 INFO - PROCESS | 13456 | RSS: Main: 186933248 02:07:08 INFO - PROCESS | 13456 | 02:07:10 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:07:11 INFO - PROCESS | 13456 | RSS: Main: 187244544 02:07:11 INFO - PROCESS | 13456 | 02:07:14 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:07:15 INFO - PROCESS | 13456 | RSS: Main: 187166720 02:07:15 INFO - PROCESS | 13456 | 02:07:16 INFO - PROCESS | 13456 | Cycle 1(1): loaded http://localhost:41409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41409/tests/kraken/driver.html?testName=ai-astar) 02:07:17 INFO - PROCESS | 13456 | RSS: Main: 187699200 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | __start_tp_report 02:07:17 INFO - PROCESS | 13456 | _x_x_mozilla_page_load 02:07:17 INFO - PROCESS | 13456 | _x_x_mozilla_page_load_details 02:07:17 INFO - PROCESS | 13456 | |i|pagename|runs| 02:07:17 INFO - PROCESS | 13456 | |0;ai-astar;114;110;117;117;116;118;114;115;112;116 02:07:17 INFO - PROCESS | 13456 | |1;audio-beat-detection;160;133;162;180;132;157;162;142;187;131 02:07:17 INFO - PROCESS | 13456 | |2;audio-dft;162;166;173;166;162;162;162;164;162;162 02:07:17 INFO - PROCESS | 13456 | |3;audio-fft;77;76;76;155;77;76;76;76;159;76 02:07:17 INFO - PROCESS | 13456 | |4;audio-oscillator;86;88;152;87;86;86;132;88;88;153 02:07:17 INFO - PROCESS | 13456 | |5;imaging-gaussian-blur;117;118;117;117;117;118;120;118;118;118 02:07:17 INFO - PROCESS | 13456 | |6;imaging-darkroom;147;149;149;148;146;147;146;147;148;147 02:07:17 INFO - PROCESS | 13456 | |7;imaging-desaturate;95;100;96;95;96;96;96;96;96;96 02:07:17 INFO - PROCESS | 13456 | |8;json-parse-financial;64;65;66;64;65;64;63;65;63;64 02:07:17 INFO - PROCESS | 13456 | |9;json-stringify-tinderbox;64;65;65;66;64;65;70;65;70;65 02:07:17 INFO - PROCESS | 13456 | |10;stanford-crypto-aes;88;85;85;83;85;86;85;84;112;85 02:07:17 INFO - PROCESS | 13456 | |11;stanford-crypto-ccm;134;148;146;132;132;131;144;146;134;135 02:07:17 INFO - PROCESS | 13456 | |12;stanford-crypto-pbkdf2;176;172;169;172;172;169;172;179;176;167 02:07:17 INFO - PROCESS | 13456 | |13;stanford-crypto-sha256-iterative;70;69;72;69;69;67;66;66;68;72 02:07:17 INFO - PROCESS | 13456 | __end_tp_report 02:07:17 INFO - PROCESS | 13456 | __start_cc_report 02:07:17 INFO - PROCESS | 13456 | _x_x_mozilla_cycle_collect,978 02:07:17 INFO - PROCESS | 13456 | __end_cc_report 02:07:17 INFO - PROCESS | 13456 | __startTimestamp1466500037089__endTimestamp 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | ------- Summary: start ------- 02:07:17 INFO - PROCESS | 13456 | Number of tests: 14 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.47 (2.1%) stddev-sans-first:2.60 02:07:17 INFO - PROCESS | 13456 | Values: 114.0 110.0 117.0 117.0 116.0 118.0 114.0 115.0 112.0 116.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#1] audio-beat-detection Cycles:10 Average:154.60 Median:161.00 stddev:19.81 (12.3%) stddev-sans-first:20.92 02:07:17 INFO - PROCESS | 13456 | Values: 160.0 133.0 162.0 180.0 132.0 157.0 162.0 142.0 187.0 131.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:3.54 (2.2%) stddev-sans-first:3.67 02:07:17 INFO - PROCESS | 13456 | Values: 162.0 166.0 173.0 166.0 162.0 162.0 162.0 164.0 162.0 162.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#3] audio-fft Cycles:10 Average:92.40 Median:76.00 stddev:34.06 (44.8%) stddev-sans-first:35.67 02:07:17 INFO - PROCESS | 13456 | Values: 77.0 76.0 76.0 155.0 77.0 76.0 76.0 76.0 159.0 76.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#4] audio-oscillator Cycles:10 Average:104.60 Median:86.50 stddev:28.90 (33.4%) stddev-sans-first:29.85 02:07:17 INFO - PROCESS | 13456 | Values: 86.0 88.0 152.0 87.0 86.0 86.0 132.0 88.0 88.0 153.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 02:07:17 INFO - PROCESS | 13456 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 120.0 118.0 118.0 118.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 02:07:17 INFO - PROCESS | 13456 | Values: 147.0 149.0 149.0 148.0 146.0 147.0 146.0 147.0 148.0 147.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.41 02:07:17 INFO - PROCESS | 13456 | Values: 95.0 100.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:1.00 02:07:17 INFO - PROCESS | 13456 | Values: 64.0 65.0 66.0 64.0 65.0 64.0 63.0 65.0 63.0 64.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:65.00 stddev:2.23 (3.4%) stddev-sans-first:2.26 02:07:17 INFO - PROCESS | 13456 | Values: 64.0 65.0 65.0 66.0 64.0 65.0 70.0 65.0 70.0 65.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:85.00 stddev:8.60 (10.1%) stddev-sans-first:9.12 02:07:17 INFO - PROCESS | 13456 | Values: 88.0 85.0 85.0 83.0 85.0 86.0 85.0 84.0 112.0 85.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:139.50 stddev:6.88 (4.9%) stddev-sans-first:7.12 02:07:17 INFO - PROCESS | 13456 | Values: 134.0 148.0 146.0 132.0 132.0 131.0 144.0 146.0 134.0 135.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:172.00 stddev:3.69 (2.1%) stddev-sans-first:3.67 02:07:17 INFO - PROCESS | 13456 | Values: 176.0 172.0 169.0 172.0 172.0 169.0 172.0 179.0 176.0 167.0 02:07:17 INFO - PROCESS | 13456 | 02:07:17 INFO - PROCESS | 13456 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:2.15 (3.1%) stddev-sans-first:2.24 02:07:17 INFO - PROCESS | 13456 | Values: 70.0 69.0 72.0 69.0 69.0 67.0 66.0 66.0 68.0 72.0 02:07:17 INFO - PROCESS | 13456 | -------- Summary: end -------- 02:07:17 INFO - PROCESS | 13456 | 02:07:18 INFO - TEST-INFO | 13456: exit 0 02:07:18 INFO - TEST-OK | kraken | took 64560ms 02:07:18 INFO - SUITE-END | took 1181s 02:07:18 INFO - Completed test suite (00:19:41) 02:07:18 INFO - javascript benchmark 02:07:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6360.503921382096, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.2106368089576, 2674.7057823639398, 2690.6367640368544, 2695.7304269573033, 2706.215197592698, 4799.088173247081, 4811.23020316749, 4852.053849499349, 4860.708357498553, 4955.826546070888, 4779.808807647699, 4856.927146092811, 4857.562819346258, 4877.414710234768, 4919.0653775782575, 4400.427944367236, 4458.041521072969, 4575.885602859922, 4585.862424127282, 4602.14860250853, 559.3117056467993, 4397.252467080604, 4407.801648925806, 4414.381986521889, 4490.932636010462, 4454.042380888109, 4465.732056076646, 4493.303537951622, 4495.5953964143055, 4511.481179664348, 4487.932681009787, 4496.2581174106235, 4502.144592527442, 4505.189065968125, 4550.249208880531, 4397.032652816375, 4430.601245887886, 4449.755263460508, 4452.1986042512335, 4457.0, 4786.928196077061, 4847.563719265283, 4876.951230487685, 4909.852704418873, 4979.775910084055, 5168.483151684839, 5172.32759741235, 5201.063808514466, 5202.453742357074, 5255.632105752599, 5222.451642577513, 5255.0, 5265.7893684252585, 5272.868178295574, 5323.574114070865, 4921.335619691367, 4931.284963680247, 4933.358663373739, 4937.950620493749, 4938.259261110862, 5216.921746173811, 5306.389765177054, 5346.304980352607, 5370.060239458079, 5384.057789886832, 5110.131277682803, 5148.073346797538, 5154.30416893722, 5161.045206636784, 5162.97418512905, 5212.087884620177, 5217.843464696065, 5227.764750586232, 5278.577713782888, 5323.840284791462, 4990.051890140861, 5064.290999260106, 5109.9744501278, 5129.435762066169, 5201.921971170435, 5120.385553733576, 5123.077845987758, 5149.665271757323, 5155.510226528474, 5157.4584668610005, 4507.842225522091, 4511.436070491189, 4515.954840451619, 4518.864434066983, 4549.658775591844, 3873.0317420644838, 3880.5925377835483, 3887.9611203888167, 3909.980450097788, 3923.2349691810396, 4484.887877803016, 4485.663575231805, 4493.168763778646, 4536.387587675687, 4547.772611369484, 5235.921461178085, 5253.868653283622, 5256.474352564713, 5275.129603615437, 5312.4156342803035, 4431.977840110779, 4493.842715504941, 4533.591976722111, 4535.931961020588, 4596.4714057883775, 4769.642276829251, 4772.117158325721, 4773.09311230865, 4807.711537307773, 4810.542998415145, 4799.28010798383, 4866.29438731389, 4873.342098816756, 4887.780049897692, 4940.184869496637, 5120.71836049006, 5148.536631703165, 5237.0835103857435, 5249.238860365149, 5267.631265811509, 4890.975545122252, 4907.828226012072, 4909.754512274443, 4916.385451818523, 4978.975105124451, 5145.279660847559, 5157.226416037624, 5185.196294574347, 5194.558462530727, 5203.141481655636, 5177.275181474672, 5195.636305458582, 5212.192110222922, 5276.023935571931, 5283.0, 5109.591232701449, 5140.588752899685, 5142.537171654569, 5156.355455568054, 5200.479952004769, 4944.554990050912, 5036.823711170238, 5132.743362831919, 5137.255098010843, 5142.742862856917, 4996.800127994839, 5026.0, 5042.193249080129, 5053.772580233972, 5108.770105345343, 5169.276301317744, 5180.300659410931, 5183.870403239949, 5201.0, 5245.527902488641, 4920.975395123001, 4921.064997650578, 5031.4213865405945, 5073.213651883964, 5077.3145625341585], "value": 4769.154298318405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.1532601389198, 578.482258378751, 579.7999690106915, 597.0238659791243, 613.7575657615239, 32913.835430822845, 37212.81393593028, 37276.068098297525, 37351.06622334443, 37370.0, 37979.43030854533, 38571.614283857154, 38696.41955370671, 38843.22313553727, 38886.8055659722, 7750.5349679019155, 7851.097123830776, 7861.8034549136155, 7864.567448790314, 7881.369490440751, 7677.769666910001, 7780.299773020427, 7836.764897053097, 7836.960815195916, 7860.921390786105, 7798.4930979486435, 7836.568988705619, 7869.527828330319, 7876.606169691521, 7897.763067107996, 7749.457537972344, 7804.648790804427, 7819.843603127905, 7821.491603045783, 7831.177726338709, 7725.150233474369, 7737.729179478748, 7803.219678032208, 7831.569263690551, 7855.8036049098655, 29539.85230073836, 36374.0, 36706.8164659175, 36717.63282367169, 36757.44863827045, 2889.2632378743497, 3078.830664313462, 3100.98449507751, 3230.3700778347998, 3389.4237979543536, 27555.0, 29848.104556863327, 29866.0, 30514.237144071354, 31078.378432431226, 2927.297448612339, 2941.2058744139176, 2944.5435957426635, 2996.865141068657, 3025.6369235691636, 242777.0, 245479.0, 248614.0, 248809.0, 249026.0, 32614.836925815693, 33478.8326058373, 33532.32935341328, 49577.25634115491, 50158.49841501611, 34384.21773604902, 34755.47866782, 34930.65069349274, 34939.82530087333, 35166.296674066376, 12305.876941230652, 12418.0, 12509.49962001528, 12509.56216532417, 12534.623961281177, 9424.246060315296, 9455.29085318604, 9458.763530911783, 9478.099580539838, 9507.809843803085, 7948.324392426593, 8110.756677299691, 8119.75640730779, 8173.7139200128895, 8248.381371397169, 3211.6627754085953, 3235.320582677664, 3243.3837570861933, 3255.283837555734, 3299.686529779667, 908.0783005249676, 921.161742814036, 935.1817159985013, 944.2304521814699, 957.9473128977974, 26623.86688066586, 27857.16428507148, 27862.263415219462, 28091.157265282076, 28155.0, 929.2473096791621, 945.7446489447948, 949.1457688080783, 955.1546881010356, 1050.7163065972297, 14866.776998345034, 14953.850461495245, 15059.849401505844, 15144.848551514344, 15205.391784328503, 391532.0, 392308.0, 392990.0, 394194.0, 397454.0, 48010.75994620074, 48494.27258591124, 48765.0, 48850.26724599134, 48903.51096489061, 1148.3970915269551, 1166.9824952625718, 1177.6408195500455, 1185.5376403202758, 1195.6353312239676, 26074.0, 27233.86383068072, 27482.725172748815, 27566.5865012029, 28019.159425217276, 40910.59089409068, 41311.38032929449, 41348.379774302804, 41362.0, 41477.37783933183, 319826.0, 324278.0, 326657.0, 327623.0, 328168.0, 25477.745222548278, 25578.10476633309, 25629.3592660185, 25639.743602563736, 25758.227253182435, 45208.54791452044, 46106.538934610224, 46509.76745116253, 47240.2913956284, 47738.28392574184, 35764.35629742655, 36367.454488183226, 36610.45084323684, 36899.81550092233, 36931.63068369282, 35908.640913591575, 35931.28137437289, 36024.81987590045, 36245.81877090598, 36296.637033629326, 35656.108597285274, 35672.0, 37995.2400951985, 38865.222695546494, 39547.40678889876, 30696.84651576728, 32559.845368488684, 33233.66766332403, 33443.66556334405, 33452.665473344954, 25424.745752542236, 25477.631069118685, 25628.103016394336, 25668.229953101436, 25695.100671477157], "value": 16239.639875481596, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.7799809113578, 372.0624027450824, 376.9038895081754, 386.19093000164645, 390.49820980040636, 15531.844681553195, 16116.0, 17124.22940967656, 17190.484285471426, 17211.569710757238, 15939.203039847991, 16297.51107466775, 17185.140742962863, 17360.305587776504, 17393.47819565412, 5061.089003979291, 5202.661826981234, 5241.528262456378, 5254.159334506479, 5286.101362768339, 5115.641905066647, 5210.452902445246, 5238.5023422774775, 5241.580673546107, 5244.947550524484, 4926.458089610158, 5123.846284611468, 5137.280780690707, 5155.845324640267, 5159.174532074869, 5061.215511595708, 5110.131277682803, 5152.304438900756, 5155.71643559604, 5165.535101840853, 4448.644108471314, 4616.53834616539, 4618.838340658061, 4622.14490319292, 4625.676202665814, 19551.413457596296, 19831.80168198314, 20636.69044964327, 20737.5852482951, 20748.377548673565, 1710.9144542772813, 1875.7467741854812, 1884.3875740384292, 2035.297822251321, 2299.3331933739196, 9230.58462369195, 9337.486438245895, 9433.622655093788, 9456.14894659484, 9466.952665236699, 1756.6486702659392, 1804.3684710351404, 1813.9818601813945, 1846.4645252876649, 1850.2229063793238, 45530.54469455296, 62528.374716253165, 68081.65959170222, 69126.65436672834, 69986.65006674985, 9655.179309758749, 9769.658061967797, 9790.951045244728, 10052.145567626687, 10525.789484210272, 13203.669908252179, 13394.93302533481, 13412.12821166621, 13470.93264533671, 13594.93202533981, 6455.160829092188, 6510.511711621647, 6732.427743641845, 6827.146606674166, 6851.657417129124, 6164.630122192682, 6260.874782504325, 6415.230172379344, 6425.710843012076, 6454.579992401664, 4126.979365103215, 4183.163367326547, 4186.6859985501205, 4230.450041494586, 4256.659467242614, 1807.4216250799882, 1847.7505536752635, 1849.2510533234063, 1852.6665200263812, 1857.2942281932778, 819.8524265632243, 883.739296907401, 884.6107712606562, 890.3411475508077, 928.8095940332215, 16348.75476867848, 16405.261763220682, 16951.915240423965, 17180.656386872193, 17191.398301059402, 834.7370578267826, 856.0925419055696, 860.7159637319669, 872.6553011560399, 875.0461996423928, 9502.334836561513, 9585.712428627152, 9661.951690241503, 9804.0, 9890.0, 388939.0, 410669.0, 411538.0, 412195.0, 414253.0, 51108.0, 52857.47142528602, 82390.0, 84028.57985710033, 88432.5578372104, 924.9213816825511, 936.9765755856158, 952.0717300631828, 982.332014230316, 986.5954958466995, 15705.136217508147, 15933.601659958595, 15963.122028288555, 16013.519594412186, 16269.67460650804, 36995.26009479849, 37673.43489847709, 37754.43368349532, 37961.62038379581, 37996.430053549775, 46198.7690061561, 46669.29996049994, 46731.29903051525, 52869.471305287996, 55418.0, 6962.860742785015, 7229.204787473269, 7272.345488906024, 7315.268473152642, 7393.55638661682, 11090.5563777448, 11868.703282418008, 11902.940485297519, 11970.521179153086, 12087.69780755453, 9866.408015519091, 9875.901240987498, 10166.0, 10181.287309888237, 10205.591776328863, 10040.14658754014, 10045.49772511386, 10046.447445390573, 10130.544125514221, 10184.745381365525, 10289.382637041801, 10568.95544156343, 10608.522616482123, 10617.787644247226, 10642.148628109888, 7518.097828260644, 7577.204393538819, 7628.084629844454, 7701.730439434593, 7734.922650773646, 10154.035366640157, 10290.228232882713, 10322.2258330624, 10477.633282835064, 10498.265121441425], "value": 8089.030349436921, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.252829679528, 1423.4448565059624, 1448.23967417106, 1597.2812234494481, 1650.4800987688884, 6572.704228309725, 7270.4910656254015, 7283.635818209094, 7766.72816451425, 7786.377089832814, 7246.0, 7520.736774212904, 7538.0, 7557.69769209231, 7586.279303466175, 2129.244118337991, 2149.9140034398683, 2150.956980860382, 2167.0140086260794, 2177.7822217778253, 2108.8523803333774, 2137.7969092936223, 2170.0994087453687, 2184.464806122502, 2189.4635814225535, 2158.98920505398, 2162.362103179566, 2163.3834357208198, 2168.577127460146, 2172.5329054253334, 2061.4124974382303, 2071.388940262626, 2072.6580114281123, 2075.2114196605194, 2080.3134965461363, 2049.4876280929766, 2065.4216819290623, 2073.6993135995194, 2089.5686454778524, 2096.895155242232, 7528.698852045912, 7587.393008559302, 7611.885821712679, 7622.923770762277, 7629.923700763033, 4361.193179261847, 4418.403515525395, 4452.532484089156, 4493.348464472666, 4495.640348772123, 2727.2500062482777, 2746.725327467257, 2748.038186634662, 2750.3674154944274, 2752.270648278208, 852.5609311204735, 869.6260607938584, 871.7166920750782, 874.1389731114847, 892.2326798952895, 10015.799684006279, 10071.09360157582, 10078.445685487295, 10114.54484548197, 10119.544620492095, 3913.745606535566, 3950.20995800841, 4025.718199725991, 4037.6769858411258, 4045.696572757055, 8699.869501957475, 8726.86909696355, 8727.781805454915, 8731.650733970697, 8740.606672699743, 4485.529019452975, 4493.415855938707, 4499.302608095751, 4500.8649740507835, 4504.61710754583, 3594.6225646307284, 3962.445257663929, 4070.409790580349, 4073.6333729964445, 4180.163967206571, 3492.2491664292297, 3537.663921927413, 3632.400653892078, 3639.3994990826745, 3719.3305205062807, 1140.1790710688292, 1156.9363684997406, 1162.2793867802018, 1165.9941700291613, 1166.8833116688263, 819.995900020496, 820.2581926514399, 834.0533494483805, 837.6021389839777, 845.0915266088979, 5032.748362581856, 5211.687298762086, 5310.840674779763, 5351.25082488452, 5362.8659283517445, 864.4251572704208, 890.7862113092941, 893.7363477774072, 922.3543519536352, 927.2813569483704, 3416.8598849130813, 3503.1373598596447, 3543.6810687037773, 3547.7516573839584, 3569.446735755962, 9065.229455496357, 9246.352755307198, 9371.859422108673, 9414.811703765887, 9451.432914025181, 9285.953570232106, 9321.0, 9328.44029358227, 9330.1136392044, 9353.345265831462, 7071.328223818729, 7187.64061796908, 7198.748043818441, 7209.062821833233, 7223.277672232734, 4906.681065730716, 5025.623078269217, 5131.538161565477, 5176.197689358156, 5219.2953951216095, 8395.748127556182, 8436.367272454469, 8590.91409085901, 8591.355648326526, 8713.041565427671, 8512.0, 8804.427712198687, 8870.334724895787, 8886.111388861062, 8888.688895888612, 5626.803061892814, 6234.470070044097, 6234.9688251558455, 6303.684815759286, 6305.716242768995, 7462.067241594801, 7464.589447580435, 7493.662785174789, 7507.174210836913, 7513.849723005618, 6560.44236239925, 6705.966470167618, 6746.966265168643, 6756.425703815231, 6815.897761533482, 6390.5526613136635, 6396.936030639634, 6416.069669897932, 6428.228612566522, 6438.742450301936, 6121.234845644294, 6181.227346581677, 6185.350538193425, 6204.100405441276, 6225.190725205694, 4276.337167739005, 4454.443194600675, 4457.621102206349, 4470.619997300266, 4500.729956202638, 4431.313146462304, 4478.149151661174, 4499.820007199806, 4501.752403617701, 4529.84145554904], "value": 4027.850359213864, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.72964966705126, 299.44602485402004, 300.99699003009977, 308.11263560944474, 309.561969812715, 5265.18389649604, 5273.34083239595, 5276.841694749154, 5282.154855223165, 5300.992811365838, 5127.564157046656, 5136.845894623168, 5145.276332428641, 5165.896682066356, 5179.171332586787, 3771.3023090728166, 3864.8260828262655, 3935.091480631891, 3956.7428117172435, 3977.548194908852, 3974.4237085622567, 3992.900177495557, 4005.3391190453685, 4022.7385219960756, 4022.9798851005703, 3983.0639799647206, 3983.741056831311, 3987.2224916141363, 3991.1219531702977, 3991.8602848900296, 3699.426588878728, 3948.7097483459524, 3948.7630742155275, 3991.263800246902, 3991.642841433912, 3434.3131373725355, 3435.9828200858838, 3444.3800115979116, 3447.207142357247, 3455.032590874559, 5003.924941125886, 5052.166392545226, 5055.368078990126, 5057.49425057495, 5078.61910356721, 4294.677899157545, 4537.546245375469, 4544.840930567414, 4556.951901062741, 4563.703359281636, 5423.728813559345, 5431.755570999315, 5433.755481003364, 5435.592330575183, 5456.372517160537, 3777.1501412182315, 3777.6788972937334, 3787.9810600947094, 3795.203007368456, 3817.866374676873, 5353.518183363477, 5611.186377975211, 5660.943390566083, 5663.546916246691, 5673.3475650299915, 3821.293060783764, 3828.693704503633, 3847.9230415391535, 3861.864834730771, 3865.9806700966315, 3921.705872059607, 3932.724709270381, 3947.763134211899, 3949.7037722170953, 3951.9802400988387, 4496.213162696515, 4524.411826462605, 4539.364488971547, 4540.0, 4554.041762042288, 5106.361704786902, 5353.652012619167, 5363.570914326922, 5405.486478784509, 5408.35045311176, 1339.9464021439032, 1346.9797953030713, 1351.196038357176, 1352.817369655084, 1352.891768658505, 835.4110352201683, 857.2456238510072, 876.3077169036517, 877.9429337093069, 939.1219210038636, 4576.633869290449, 4606.355110284563, 4640.213517795605, 4666.556677115668, 4706.905861882743, 5448.83653490396, 5469.206964990134, 5505.0, 5560.165975103767, 5586.13414920688, 4558.817647294138, 4660.86017419478, 4737.194676904935, 4743.667943244009, 4755.809767609326, 2941.470535303666, 2952.763778897683, 2956.2609347663083, 2958.290010397489, 2960.2155428811384, 5135.281060651511, 5139.794408223629, 5142.922856157161, 5149.613778966517, 5156.20078887773, 5531.557475401958, 5541.668515532971, 5627.0, 5658.868226354745, 5704.258446401941, 5137.717425541631, 5165.974170129125, 5185.766640501187, 5201.765920533585, 5221.765020574007, 5508.0, 5520.66875987442, 5524.1989911463415, 5529.281193444987, 5609.6073274872, 5150.48495150482, 5455.208994695826, 5464.23500709893, 5479.534209605614, 5487.945120548743, 5155.381354237516, 5173.611979101507, 5175.637705360588, 5240.318758561362, 5244.449332819999, 4005.097578650118, 4009.0, 4030.5163380394542, 4041.474608300902, 4043.5147782266317, 5358.598105142052, 5430.456954304538, 5442.9930462864495, 5471.835844924659, 5490.368607610176, 5270.762815673227, 5328.866778330417, 5336.466353364633, 5338.38608560005, 5365.490278423544, 5167.379914410144, 5265.4320067942335, 5306.442823503477, 5328.307320048369, 5355.384130824849, 5232.843014709565, 5250.448702886142, 5268.367795864521, 5271.525562699376, 5299.920501192562, 5189.974050129726, 5258.526732594085, 5419.756110974937, 5435.673859568438, 5486.972565137149, 5299.576033917355, 5319.654222475527, 5324.2580071262555, 5327.813526526553, 5384.869177472775], "value": 4027.28163217558, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.6915080761235, 655.1352215076101, 670.8993650952359, 728.9526180798248, 744.3040756892306, 12058.216215945957, 13215.867841321584, 13372.933135334333, 13421.463141474354, 13558.050936434454, 12748.235105893653, 12777.55278565248, 12886.742265154691, 12896.613101606967, 12968.0, 625.9280182778994, 746.5968377076372, 770.2451597434517, 774.094309657699, 791.70311133325, 784.1022029775903, 787.5117427195147, 788.8343447875953, 789.5933594198992, 791.5409062743595, 832.142892820396, 838.714836955435, 839.9202075802789, 840.5419046619606, 841.4908980067063, 820.9794755131139, 822.5517093184229, 824.8597738384459, 826.3141592478229, 829.7096016394274, 605.1890466774499, 605.4339192854695, 608.6500262349123, 609.7073404765692, 610.9389061093855, 13216.801747973788, 13237.73524529504, 13244.867551324556, 13265.668358291023, 13288.26914519701, 13239.73520529584, 13498.392572334269, 13500.189988600716, 13609.11540749858, 13956.72086558263, 10617.097546708539, 10665.306755060896, 10778.19163562736, 10839.13286937043, 10955.671329860037, 3273.3780581689402, 3323.0, 3338.582677165354, 3345.6654334566592, 3351.1287065362935, 60444.69777651084, 61023.69488152575, 61055.69472152655, 62069.379306207265, 62755.6862215686, 9640.807183856425, 9824.06671366219, 9984.750381240527, 10173.237007224488, 10238.53926573306, 16955.0, 19514.414567562995, 19524.511887202934, 19635.705464418046, 19712.112954917062, 6987.965060174666, 7368.37368823656, 7369.373603243785, 7374.299441553044, 7461.664225109883, 3945.151792364598, 4022.1151346703678, 4029.435878976946, 4047.1905618876344, 4085.080856807195, 2894.493463643896, 2992.7456166226116, 2995.311078451968, 2996.9100926972224, 2999.2651800309063, 488.79226328810114, 494.06621485392634, 504.11527768766314, 504.75771629617253, 504.8813528820724, 480.8052738640856, 587.3597778421541, 613.5183880653666, 619.1641284266204, 619.9105345116643, 8092.9190708092165, 8098.230668086522, 8132.1867813218205, 8183.0, 8379.203975622306, 571.2801869644195, 598.6228675934134, 603.5232166588434, 621.1825218229891, 638.3999040901631, 3917.8236979335998, 3948.447217389568, 3951.4072889066297, 4007.0182805212908, 4038.273110840018, 87607.56196218978, 88491.55754221187, 89509.55245223732, 91131.0, 93058.53470732739, 81642.59178704068, 83480.58259708663, 84503.5774821122, 85248.0, 85802.57098714466, 43160.352594711105, 43315.56684433115, 44986.77506612446, 45158.54841451609, 73916.0, 7276.818079548054, 7508.962455187689, 7652.349550288065, 7743.612819358897, 7811.218878112143, 43658.126837462434, 44388.0, 44679.9999999987, 44680.106397872514, 45126.77436612796, 42870.785646072814, 56042.0, 56160.0, 60193.0, 60866.69566652139, 10586.629467968583, 10752.139828813833, 10916.263044889336, 11026.669199924016, 11561.826572601585, 12679.175853569488, 13232.536861209812, 13306.268155251168, 13328.866711332763, 13537.0, 11787.115966302734, 11861.5848445304, 12452.252864828139, 12567.93716031414, 12698.174618649758, 12119.212251203644, 12147.271163730204, 12189.146759726735, 12288.324142172267, 12415.813762793747, 10627.309224900357, 11347.48936297852, 11670.474828632561, 12043.397830108284, 12435.564755233885, 9400.529973501434, 9847.753806154904, 9872.703818885446, 9886.555105020147, 10199.031092046243, 10182.389056656624, 10311.690649280534, 10392.116670082825, 10413.0, 10483.842742358718], "value": 6514.865602750819, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1589.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 117.0, 117.0, 116.0, 118.0, 114.0, 115.0, 112.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 133.0, 162.0, 180.0, 132.0, 157.0, 162.0, 142.0, 187.0, 131.0], "value": 154.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 173.0, 166.0, 162.0, 162.0, 162.0, 164.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 155.0, 77.0, 76.0, 76.0, 76.0, 159.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 152.0, 87.0, 86.0, 86.0, 132.0, 88.0, 88.0, 153.0], "value": 104.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 120.0, 118.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 149.0, 148.0, 146.0, 147.0, 146.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 66.0, 64.0, 65.0, 64.0, 63.0, 65.0, 63.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 64.0, 65.0, 70.0, 65.0, 70.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 83.0, 85.0, 86.0, 85.0, 84.0, 112.0, 85.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 148.0, 146.0, 132.0, 132.0, 131.0, 144.0, 146.0, 134.0, 135.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 172.0, 169.0, 172.0, 172.0, 169.0, 172.0, 179.0, 176.0, 167.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 72.0, 69.0, 69.0, 67.0, 66.0, 66.0, 68.0, 72.0], "value": 68.8, "unit": "score"}]}]} 02:07:18 INFO - Return code: 0 02:07:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:07:18 ERROR - # TBPL SUCCESS # 02:07:18 INFO - Running post-action listener: _resource_record_post_action 02:07:18 INFO - ##### 02:07:18 INFO - ##### Finished run-tests step (success) 02:07:18 INFO - ##### 02:07:18 INFO - Running post-run listener: _resource_record_post_run 02:07:18 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 545411072; Read time: 184; Write time: 433500 02:07:18 INFO - TinderboxPrint: CPU usage
13.5% 02:07:18 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 02:07:18 INFO - TinderboxPrint: I/O write bytes / time
545,411,072 / 433,500 02:07:18 INFO - TinderboxPrint: CPU idle
8,275.9 (86.5%) 02:07:18 INFO - TinderboxPrint: CPU user
1,233.1 (12.9%) 02:07:18 INFO - TinderboxPrint: Swap in / out
0 / 0 02:07:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245846016; Read time: 0; Write time: 241584 02:07:18 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 8192; Write bytes: 299565056; Read time: 184; Write time: 191916 02:07:19 INFO - Running post-run listener: _upload_blobber_files 02:07:19 INFO - Blob upload gear active. 02:07:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:07:19 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 02:07:19 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'] 02:07:19 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 02:07:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:07:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:07:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:07:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:20 INFO - (blobuploader) - INFO - Done attempting. 02:07:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:07:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:07:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:23 INFO - (blobuploader) - INFO - Done attempting. 02:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:24 INFO - (blobuploader) - INFO - Done attempting. 02:07:24 INFO - (blobuploader) - INFO - Iteration through files over. 02:07:24 INFO - Return code: 0 02:07:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:07:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:07:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1917411a801ae694bbf6bc85477fa35afa888d759e9ce5f4298125a2018d923e95c09f02e1d82dbac5834bb792985b7cbec85bce4527056f2ddd2764fea14ae9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3a969efe66b50af572cee02e6aac02059a39860bc02f925351e2eb10ef72adb24d0e8a97c158e5cfe02e0960f607830b13b4f682459f8923bdf70d3be957439", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f919e2e87f80bbe1e840c72ac070a504517a2f0f47edb7613615ce378f64a94942efefeff3814ee273458a9df706e11bde566893ae4e39a5168e783f7596d88d"} 02:07:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:07:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:07:24 INFO - Contents: 02:07:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1917411a801ae694bbf6bc85477fa35afa888d759e9ce5f4298125a2018d923e95c09f02e1d82dbac5834bb792985b7cbec85bce4527056f2ddd2764fea14ae9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3a969efe66b50af572cee02e6aac02059a39860bc02f925351e2eb10ef72adb24d0e8a97c158e5cfe02e0960f607830b13b4f682459f8923bdf70d3be957439", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f919e2e87f80bbe1e840c72ac070a504517a2f0f47edb7613615ce378f64a94942efefeff3814ee273458a9df706e11bde566893ae4e39a5168e783f7596d88d"} 02:07:24 INFO - Running post-run listener: copy_logs_to_upload_dir 02:07:24 INFO - Copying logs to upload dir... 02:07:24 INFO - mkdir: /builds/slave/test/build/upload/logs 02:07:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.835887 ========= master_lag: 1.59 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-21 02:07:25.253380) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-06-21 02:07:25.256915) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166 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/1917411a801ae694bbf6bc85477fa35afa888d759e9ce5f4298125a2018d923e95c09f02e1d82dbac5834bb792985b7cbec85bce4527056f2ddd2764fea14ae9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3a969efe66b50af572cee02e6aac02059a39860bc02f925351e2eb10ef72adb24d0e8a97c158e5cfe02e0960f607830b13b4f682459f8923bdf70d3be957439", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f919e2e87f80bbe1e840c72ac070a504517a2f0f47edb7613615ce378f64a94942efefeff3814ee273458a9df706e11bde566893ae4e39a5168e783f7596d88d"} build_url:https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/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/1917411a801ae694bbf6bc85477fa35afa888d759e9ce5f4298125a2018d923e95c09f02e1d82dbac5834bb792985b7cbec85bce4527056f2ddd2764fea14ae9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f3a969efe66b50af572cee02e6aac02059a39860bc02f925351e2eb10ef72adb24d0e8a97c158e5cfe02e0960f607830b13b4f682459f8923bdf70d3be957439", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f919e2e87f80bbe1e840c72ac070a504517a2f0f47edb7613615ce378f64a94942efefeff3814ee273458a9df706e11bde566893ae4e39a5168e783f7596d88d"}' ========= master_lag: 3.46 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-06-21 02:07:28.724162) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:07:28.724484) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1466498679.694234-998801166 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:07:28.742766) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:07:28.743066) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:07:28.743328) ========= ========= Total master_lag: 5.12 =========