builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1466804644.61 results: success (0) buildid: 20160624134259 builduid: e4f43921d958405fa9aa48b86b5daa93 revision: 0cfc0fa7df034a592eb0ef580e0041a5c037bfa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.606617) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.607128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.607759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.640651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.641034) ========= 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=41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-24 14:44:04-- 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% 225M=0s 2016-06-24 14:44:04 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.742922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.743622) ========= 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=41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015881 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:04.794462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 14:44:04.794863) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 0cfc0fa7df034a592eb0ef580e0041a5c037bfa3 --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 0cfc0fa7df034a592eb0ef580e0041a5c037bfa3 --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=41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-24 14:44:04,943 truncating revision to first 12 chars 2016-06-24 14:44:04,944 Setting DEBUG logging. 2016-06-24 14:44:04,944 attempt 1/10 2016-06-24 14:44:04,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/0cfc0fa7df03?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-24 14:44:06,289 unpacking tar archive at: fx-team-0cfc0fa7df03/testing/mozharness/ program finished with exit code 0 elapsedTime=1.689806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-24 14:44:06.499130) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:06.499504) ========= script_repo_revision: 0cfc0fa7df034a592eb0ef580e0041a5c037bfa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:06.499990) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:06.500327) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-24 14:44:06.510448) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 9 secs) (at 2016-06-24 14:44:06.510834) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:44:06 INFO - MultiFileLogger online at 20160624 14:44:06 in /builds/slave/test 14:44:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 14:44:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:44:06 INFO - {'append_to_log': False, 14:44:06 INFO - 'base_work_dir': '/builds/slave/test', 14:44:06 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:44:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:44:06 INFO - 'branch': 'Fx-Team-Non-PGO', 14:44:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:44:06 INFO - 'config_files': ('talos/linux_config.py',), 14:44:06 INFO - 'default_actions': ('clobber', 14:44:06 INFO - 'read-buildbot-config', 14:44:06 INFO - 'download-and-extract', 14:44:06 INFO - 'populate-webroot', 14:44:06 INFO - 'create-virtualenv', 14:44:06 INFO - 'install', 14:44:06 INFO - 'run-tests'), 14:44:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:44:06 INFO - 'download_minidump_stackwalk': True, 14:44:06 INFO - 'download_symbols': 'ondemand', 14:44:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:44:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:44:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:44:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:44:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:44:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:44:06 INFO - 'installer_path': 'installer.exe', 14:44:06 INFO - 'log_level': 'info', 14:44:06 INFO - 'log_name': 'talos', 14:44:06 INFO - 'log_to_console': True, 14:44:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:44:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:44:06 INFO - 'opt_config_files': (), 14:44:06 INFO - 'pip_index': False, 14:44:06 INFO - 'sps_profile': False, 14:44:06 INFO - 'sps_profile_interval': 0, 14:44:06 INFO - 'suite': 'dromaeojs', 14:44:06 INFO - 'system_bits': '32', 14:44:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:44:06 INFO - 'title': 'talos-linux64-ix-026', 14:44:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:44:06 INFO - 'use_talos_json': True, 14:44:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:44:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:44:06 INFO - 'work_dir': 'build'} 14:44:06 INFO - ##### 14:44:06 INFO - ##### Running clobber step. 14:44:06 INFO - ##### 14:44:06 INFO - Running pre-action listener: _resource_record_pre_action 14:44:06 INFO - Running main action method: clobber 14:44:06 INFO - rmtree: /builds/slave/test/build 14:44:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:44:07 INFO - Running post-action listener: _resource_record_post_action 14:44:07 INFO - ##### 14:44:07 INFO - ##### Finished clobber step (success) 14:44:07 INFO - ##### 14:44:07 INFO - ##### 14:44:07 INFO - ##### Running read-buildbot-config step. 14:44:07 INFO - ##### 14:44:07 INFO - Running pre-action listener: _resource_record_pre_action 14:44:07 INFO - Running main action method: read_buildbot_config 14:44:07 INFO - Using buildbot properties: 14:44:07 INFO - { 14:44:07 INFO - "project": "", 14:44:07 INFO - "product": "firefox", 14:44:07 INFO - "script_repo_revision": "production", 14:44:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 14:44:07 INFO - "repository": "", 14:44:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 14:44:07 INFO - "buildid": "20160624134259", 14:44:07 INFO - "pgo_build": "False", 14:44:07 INFO - "basedir": "/builds/slave/test", 14:44:07 INFO - "buildnumber": 1772, 14:44:07 INFO - "slavename": "talos-linux64-ix-026", 14:44:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:44:07 INFO - "platform": "ubuntu64_hw", 14:44:07 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:44:07 INFO - "branch": "fx-team", 14:44:07 INFO - "repo_path": "integration/fx-team", 14:44:07 INFO - "revision": "0cfc0fa7df034a592eb0ef580e0041a5c037bfa3", 14:44:07 INFO - "stage_platform": "linux64", 14:44:07 INFO - "builduid": "e4f43921d958405fa9aa48b86b5daa93", 14:44:07 INFO - "slavebuilddir": "test" 14:44:07 INFO - } 14:44:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:44:07 INFO - Running post-action listener: _resource_record_post_action 14:44:07 INFO - ##### 14:44:07 INFO - ##### Finished read-buildbot-config step (success) 14:44:07 INFO - ##### 14:44:07 INFO - ##### 14:44:07 INFO - ##### Running download-and-extract step. 14:44:07 INFO - ##### 14:44:07 INFO - Running pre-action listener: _resource_record_pre_action 14:44:07 INFO - Running main action method: download_and_extract 14:44:07 INFO - mkdir: /builds/slave/test/build/tests 14:44:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:44:07 INFO - https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:44:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:44:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:44:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:44:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:44:09 INFO - Downloaded 1361 bytes. 14:44:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:44:09 INFO - Using the following test package requirements: 14:44:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:44:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:44:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:44:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'jsshell-linux-x86_64.zip'], 14:44:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:44:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:44:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:44:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:44:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:44:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:44:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:44:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:44:09 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')]} 14:44:09 INFO - https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:44:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:44:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:44:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:44:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:51:41 INFO - Downloaded 22713106 bytes. 14:51:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:51:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:51:42 INFO - Return code: 0 14:51:42 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 14:51:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:51:42 INFO - https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:51:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:51:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:51:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:51:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:51:43 INFO - Downloaded 22713106 bytes. 14:51:43 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'] 14:51:43 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 14:51:45 INFO - Return code: 0 14:51:45 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')]} 14:51:45 INFO - https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:55:36 INFO - Downloaded 14405188 bytes. 14:55:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:55:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:55:36 INFO - Return code: 0 14:55:36 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')]} 14:55:36 INFO - https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BGYy3c27S22-Bi3r8qDWDA/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 14:55:42 INFO - Downloaded 56258017 bytes. 14:55:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:55:42 INFO - mkdir: /builds/slave/test/properties 14:55:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:55:42 INFO - Writing to file /builds/slave/test/properties/build_url 14:55:42 INFO - Contents: 14:55:42 INFO - build_url:https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:55:44 INFO - Running post-action listener: _resource_record_post_action 14:55:44 INFO - Running post-action listener: set_extra_try_arguments 14:55:44 INFO - ##### 14:55:44 INFO - ##### Finished download-and-extract step (success) 14:55:44 INFO - ##### 14:55:44 INFO - ##### 14:55:44 INFO - ##### Running populate-webroot step. 14:55:44 INFO - ##### 14:55:44 INFO - Running pre-action listener: _resource_record_pre_action 14:55:44 INFO - Running main action method: populate_webroot 14:55:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:55:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:55:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:55:44 INFO - '--tppagecycles', 14:55:44 INFO - '7'], 14:55:44 INFO - 'tests': ['tsvgm']}}, 14:55:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:55:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:55:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:55:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:55:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:55:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['damp', 'tps']}, 14:55:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'tests': ['damp', 'tps']}, 14:55:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['dromaeo_dom']}, 14:55:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:55:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['basic_compositor_video']}, 14:55:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:55:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['a11yr', 14:55:44 INFO - 'ts_paint', 14:55:44 INFO - 'tpaint', 14:55:44 INFO - 'sessionrestore', 14:55:44 INFO - 'sessionrestore_no_auto_restore', 14:55:44 INFO - 'tabpaint']}, 14:55:44 INFO - 'other-e10s': {'tests': ['a11yr', 14:55:44 INFO - 'ts_paint', 14:55:44 INFO - 'tpaint', 14:55:44 INFO - 'sessionrestore', 14:55:44 INFO - 'sessionrestore_no_auto_restore', 14:55:44 INFO - 'tabpaint']}, 14:55:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:55:44 INFO - 'ts_paint', 14:55:44 INFO - 'tpaint', 14:55:44 INFO - 'sessionrestore', 14:55:44 INFO - 'sessionrestore_no_auto_restore', 14:55:44 INFO - 'tabpaint']}, 14:55:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:55:44 INFO - 'ts_paint', 14:55:44 INFO - 'tpaint', 14:55:44 INFO - 'sessionrestore', 14:55:44 INFO - 'sessionrestore_no_auto_restore', 14:55:44 INFO - 'tabpaint']}, 14:55:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['a11yr', 14:55:44 INFO - 'ts_paint', 14:55:44 INFO - 'tpaint', 14:55:44 INFO - 'sessionrestore', 14:55:44 INFO - 'sessionrestore_no_auto_restore', 14:55:44 INFO - 'tabpaint']}, 14:55:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['a11yr', 14:55:44 INFO - 'ts_paint', 14:55:44 INFO - 'tpaint', 14:55:44 INFO - 'sessionrestore', 14:55:44 INFO - 'sessionrestore_no_auto_restore', 14:55:44 INFO - 'tabpaint']}, 14:55:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['tsvgx', 14:55:44 INFO - 'tsvgr_opacity', 14:55:44 INFO - 'tart', 14:55:44 INFO - 'tscrollx', 14:55:44 INFO - 'cart']}, 14:55:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:55:44 INFO - 'tsvgr_opacity', 14:55:44 INFO - 'tart', 14:55:44 INFO - 'tscrollx', 14:55:44 INFO - 'cart']}, 14:55:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'talos_options': ['--disable-e10s'], 14:55:44 INFO - 'tests': ['tp5o']}, 14:55:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'tests': ['tp5o']}, 14:55:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'talos_options': ['--disable-e10s', 14:55:44 INFO - '--xperf_path', 14:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:44 INFO - 'tests': ['tp5n']}, 14:55:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:55:44 INFO - 'talos_options': ['--xperf_path', 14:55:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:55:44 INFO - 'tests': ['tp5n']}}, 14:55:44 INFO - 'talos.zip': {'path': '', 14:55:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:55:44 INFO - Running post-action listener: _resource_record_post_action 14:55:44 INFO - ##### 14:55:44 INFO - ##### Finished populate-webroot step (success) 14:55:44 INFO - ##### 14:55:44 INFO - ##### 14:55:44 INFO - ##### Running create-virtualenv step. 14:55:44 INFO - ##### 14:55:44 INFO - Running pre-action listener: _resource_record_pre_action 14:55:44 INFO - Running main action method: create_virtualenv 14:55:44 INFO - Creating virtualenv /builds/slave/test/build/venv 14:55:44 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 14:55:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:55:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:55:44 INFO - Using real prefix '/usr' 14:55:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:55:44 INFO - Installing distribute.............................................................................................................................................................................................done. 14:55:46 INFO - Installing pip.................done. 14:55:46 INFO - Return code: 0 14:55:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:55:46 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')]} 14:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:46 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')]} 14:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:46 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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:55:46 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 14:55:46 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 14:55:46 INFO - Using env: {'DISPLAY': ':0', 14:55:46 INFO - 'HOME': '/home/cltbld', 14:55:46 INFO - 'LANG': 'en_US.UTF-8', 14:55:46 INFO - 'LANGUAGE': 'en_US:en', 14:55:46 INFO - 'LOGNAME': 'cltbld', 14:55:46 INFO - 'MAIL': '/var/mail/cltbld', 14:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:46 INFO - 'MOZ_NO_REMOTE': '1', 14:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:46 INFO - 'NO_EM_RESTART': '1', 14:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:46 INFO - 'PWD': '/builds/slave/test', 14:55:46 INFO - 'SHELL': '/bin/bash', 14:55:46 INFO - 'SHLVL': '1', 14:55:46 INFO - 'TERM': 'linux', 14:55:46 INFO - 'TMOUT': '86400', 14:55:46 INFO - 'USER': 'cltbld', 14:55:46 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:46 INFO - '_': '/tools/buildbot/bin/python'} 14:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:47 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 14:55:47 INFO - Cleaning up... 14:55:47 INFO - Return code: 0 14:55:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:55: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')]} 14:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55: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')]} 14:55:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:55:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:55:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:55:47 INFO - Using env: {'DISPLAY': ':0', 14:55:47 INFO - 'HOME': '/home/cltbld', 14:55:47 INFO - 'LANG': 'en_US.UTF-8', 14:55:47 INFO - 'LANGUAGE': 'en_US:en', 14:55:47 INFO - 'LOGNAME': 'cltbld', 14:55:47 INFO - 'MAIL': '/var/mail/cltbld', 14:55:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:47 INFO - 'MOZ_NO_REMOTE': '1', 14:55:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:47 INFO - 'NO_EM_RESTART': '1', 14:55:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:47 INFO - 'PWD': '/builds/slave/test', 14:55:47 INFO - 'SHELL': '/bin/bash', 14:55:47 INFO - 'SHLVL': '1', 14:55:47 INFO - 'TERM': 'linux', 14:55:47 INFO - 'TMOUT': '86400', 14:55:47 INFO - 'USER': 'cltbld', 14:55:47 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:55:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:47 INFO - '_': '/tools/buildbot/bin/python'} 14:55:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:47 INFO - Downloading/unpacking psutil>=3.1.1 14:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:49 INFO - Installing collected packages: psutil 14:55:49 INFO - Running setup.py install for psutil 14:55:49 INFO - building 'psutil._psutil_linux' extension 14:55:49 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 14:55:49 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 14:55:49 INFO - building 'psutil._psutil_posix' extension 14:55:49 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 14:55:49 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 14:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:55:49 INFO - Successfully installed psutil 14:55:49 INFO - Cleaning up... 14:55:49 INFO - Return code: 0 14:55:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:55: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')]} 14:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55: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')]} 14:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:55:49 INFO - Using env: {'DISPLAY': ':0', 14:55:49 INFO - 'HOME': '/home/cltbld', 14:55:49 INFO - 'LANG': 'en_US.UTF-8', 14:55:49 INFO - 'LANGUAGE': 'en_US:en', 14:55:49 INFO - 'LOGNAME': 'cltbld', 14:55:49 INFO - 'MAIL': '/var/mail/cltbld', 14:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:49 INFO - 'MOZ_NO_REMOTE': '1', 14:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:49 INFO - 'NO_EM_RESTART': '1', 14:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:49 INFO - 'PWD': '/builds/slave/test', 14:55:49 INFO - 'SHELL': '/bin/bash', 14:55:49 INFO - 'SHLVL': '1', 14:55:49 INFO - 'TERM': 'linux', 14:55:49 INFO - 'TMOUT': '86400', 14:55:49 INFO - 'USER': 'cltbld', 14:55:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:49 INFO - '_': '/tools/buildbot/bin/python'} 14:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:55:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:55:51 INFO - Installing collected packages: mozsystemmonitor 14:55:51 INFO - Running setup.py install for mozsystemmonitor 14:55:52 INFO - Successfully installed mozsystemmonitor 14:55:52 INFO - Cleaning up... 14:55:52 INFO - Return code: 0 14:55:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:55:52 INFO - Using env: {'DISPLAY': ':0', 14:55:52 INFO - 'HOME': '/home/cltbld', 14:55:52 INFO - 'LANG': 'en_US.UTF-8', 14:55:52 INFO - 'LANGUAGE': 'en_US:en', 14:55:52 INFO - 'LOGNAME': 'cltbld', 14:55:52 INFO - 'MAIL': '/var/mail/cltbld', 14:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:52 INFO - 'MOZ_NO_REMOTE': '1', 14:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:52 INFO - 'NO_EM_RESTART': '1', 14:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:52 INFO - 'PWD': '/builds/slave/test', 14:55:52 INFO - 'SHELL': '/bin/bash', 14:55:52 INFO - 'SHLVL': '1', 14:55:52 INFO - 'TERM': 'linux', 14:55:52 INFO - 'TMOUT': '86400', 14:55:52 INFO - 'USER': 'cltbld', 14:55:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:52 INFO - '_': '/tools/buildbot/bin/python'} 14:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:52 INFO - Downloading/unpacking jsonschema==2.5.1 14:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:55:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:55:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:55:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 INFO - Downloading functools32-3.2.3-2.tar.gz 14:55:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:55:54 INFO - warning: no files found matching '*.txt' 14:55:54 INFO - no previously-included directories found matching 'build' 14:55:54 INFO - no previously-included directories found matching 'dist' 14:55:54 INFO - no previously-included directories found matching '.git*' 14:55:54 INFO - Installing collected packages: jsonschema, functools32 14:55:54 INFO - Running setup.py install for functools32 14:55:54 INFO - warning: no files found matching '*.txt' 14:55:54 INFO - no previously-included directories found matching 'build' 14:55:54 INFO - no previously-included directories found matching 'dist' 14:55:54 INFO - no previously-included directories found matching '.git*' 14:55:54 INFO - Successfully installed jsonschema functools32 14:55:54 INFO - Cleaning up... 14:55:54 INFO - Return code: 0 14:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:54 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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:55:54 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 14:55:54 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 14:55:54 INFO - Using env: {'DISPLAY': ':0', 14:55:54 INFO - 'HOME': '/home/cltbld', 14:55:54 INFO - 'LANG': 'en_US.UTF-8', 14:55:54 INFO - 'LANGUAGE': 'en_US:en', 14:55:54 INFO - 'LOGNAME': 'cltbld', 14:55:54 INFO - 'MAIL': '/var/mail/cltbld', 14:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:54 INFO - 'MOZ_NO_REMOTE': '1', 14:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:54 INFO - 'NO_EM_RESTART': '1', 14:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:54 INFO - 'PWD': '/builds/slave/test', 14:55:54 INFO - 'SHELL': '/bin/bash', 14:55:54 INFO - 'SHLVL': '1', 14:55:54 INFO - 'TERM': 'linux', 14:55:54 INFO - 'TMOUT': '86400', 14:55:54 INFO - 'USER': 'cltbld', 14:55:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:54 INFO - '_': '/tools/buildbot/bin/python'} 14:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:54 INFO - Downloading/unpacking blobuploader==1.2.4 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 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 14:55:54 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 14:55:56 INFO - Downloading blobuploader-1.2.4.tar.gz 14:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:55:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:55:56 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 14:55:56 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 14:55:56 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 14:55:56 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 14:55:56 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 14:55:56 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 14:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:55:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:55: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 14:55: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 14:55: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 14:55: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 14:55: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 14:55: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 14:55:57 INFO - Downloading docopt-0.6.1.tar.gz 14:55:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 14:55:57 INFO - Running setup.py install for blobuploader 14:55:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:55:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:55:57 INFO - Running setup.py install for requests 14:55:57 INFO - Running setup.py install for docopt 14:55:58 INFO - Successfully installed blobuploader requests docopt 14:55:58 INFO - Cleaning up... 14:55:58 INFO - Return code: 0 14:55:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:55:58 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')]} 14:55:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:55:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:58 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')]} 14:55:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:55:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:55:58 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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:55:58 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 14:55:58 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 14:55:58 INFO - Using env: {'DISPLAY': ':0', 14:55:58 INFO - 'HOME': '/home/cltbld', 14:55:58 INFO - 'LANG': 'en_US.UTF-8', 14:55:58 INFO - 'LANGUAGE': 'en_US:en', 14:55:58 INFO - 'LOGNAME': 'cltbld', 14:55:58 INFO - 'MAIL': '/var/mail/cltbld', 14:55:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:55:58 INFO - 'MOZ_NO_REMOTE': '1', 14:55:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:55:58 INFO - 'NO_EM_RESTART': '1', 14:55:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:55:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:55:58 INFO - 'PWD': '/builds/slave/test', 14:55:58 INFO - 'SHELL': '/bin/bash', 14:55:58 INFO - 'SHLVL': '1', 14:55:58 INFO - 'TERM': 'linux', 14:55:58 INFO - 'TMOUT': '86400', 14:55:58 INFO - 'USER': 'cltbld', 14:55:58 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:55:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:55:58 INFO - '_': '/tools/buildbot/bin/python'} 14:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:55:58 INFO - Running setup.py (path:/tmp/pip-shO4Si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:55:58 INFO - Running setup.py (path:/tmp/pip-ablSuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:55:58 INFO - Running setup.py (path:/tmp/pip-yGgJf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:55:58 INFO - Running setup.py (path:/tmp/pip-tk1aVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:55:58 INFO - Running setup.py (path:/tmp/pip-lnZPxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:55:58 INFO - Running setup.py (path:/tmp/pip-M3hzOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:55:58 INFO - Running setup.py (path:/tmp/pip-lC61I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:55:58 INFO - Running setup.py (path:/tmp/pip-jKnNek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:55:58 INFO - Running setup.py (path:/tmp/pip-Vgjmpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:55:59 INFO - Running setup.py (path:/tmp/pip-pxbyDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:55:59 INFO - Running setup.py (path:/tmp/pip-Me07_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:55:59 INFO - Running setup.py (path:/tmp/pip-ydUSAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:55:59 INFO - Running setup.py (path:/tmp/pip-dcIeQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:55:59 INFO - Running setup.py (path:/tmp/pip-6ubaep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:59 INFO - Running setup.py (path:/tmp/pip-tLmnKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:55:59 INFO - Running setup.py (path:/tmp/pip-NswMtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:55:59 INFO - Running setup.py (path:/tmp/pip-0pJ7SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:55:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:55:59 INFO - Running setup.py install for manifestparser 14:55:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:55:59 INFO - Running setup.py install for mozcrash 14:55:59 INFO - Running setup.py install for mozdebug 14:55:59 INFO - Running setup.py install for mozdevice 14:55:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:55:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozfile 14:56:00 INFO - Running setup.py install for mozhttpd 14:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozinfo 14:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozInstall 14:56:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozleak 14:56:00 INFO - Running setup.py install for mozlog 14:56:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for moznetwork 14:56:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozprocess 14:56:00 INFO - Running setup.py install for mozprofile 14:56:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:56:00 INFO - Running setup.py install for mozrunner 14:56:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Running setup.py install for mozscreenshot 14:56:01 INFO - Running setup.py install for moztest 14:56:01 INFO - Running setup.py install for mozversion 14:56:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:56:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:56:01 INFO - Cleaning up... 14:56:01 INFO - Return code: 0 14:56:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:01 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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:56:01 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 14:56:01 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 14:56:01 INFO - Using env: {'DISPLAY': ':0', 14:56:01 INFO - 'HOME': '/home/cltbld', 14:56:01 INFO - 'LANG': 'en_US.UTF-8', 14:56:01 INFO - 'LANGUAGE': 'en_US:en', 14:56:01 INFO - 'LOGNAME': 'cltbld', 14:56:01 INFO - 'MAIL': '/var/mail/cltbld', 14:56:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:01 INFO - 'MOZ_NO_REMOTE': '1', 14:56:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:01 INFO - 'NO_EM_RESTART': '1', 14:56:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:01 INFO - 'PWD': '/builds/slave/test', 14:56:01 INFO - 'SHELL': '/bin/bash', 14:56:01 INFO - 'SHLVL': '1', 14:56:01 INFO - 'TERM': 'linux', 14:56:01 INFO - 'TMOUT': '86400', 14:56:01 INFO - 'USER': 'cltbld', 14:56:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:56:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:01 INFO - '_': '/tools/buildbot/bin/python'} 14:56:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:56:01 INFO - Running setup.py (path:/tmp/pip-G6LmLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:56:01 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)) 14:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:56:01 INFO - Running setup.py (path:/tmp/pip-03AXhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:56:01 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)) 14:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:56:01 INFO - Running setup.py (path:/tmp/pip-QDKz9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:56:01 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)) 14:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:56:01 INFO - Running setup.py (path:/tmp/pip-Mb0YRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:56:01 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)) 14:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:56:01 INFO - Running setup.py (path:/tmp/pip-V_fGI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:56:01 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)) 14:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:56:01 INFO - Running setup.py (path:/tmp/pip-swHHQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:56:02 INFO - Running setup.py (path:/tmp/pip-yKsPou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:56:02 INFO - Running setup.py (path:/tmp/pip-9L6YNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:56:02 INFO - Running setup.py (path:/tmp/pip-0aBcxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:56:02 INFO - Running setup.py (path:/tmp/pip-f7oXEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:56:02 INFO - Running setup.py (path:/tmp/pip-Rl2isp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:56:02 INFO - Running setup.py (path:/tmp/pip-l5NAfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:56:02 INFO - Running setup.py (path:/tmp/pip-mKdb52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:56:02 INFO - Running setup.py (path:/tmp/pip-Mgfero-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:02 INFO - Running setup.py (path:/tmp/pip-AheMNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:56:02 INFO - Running setup.py (path:/tmp/pip-_nvs71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:56:02 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)) 14:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:56:02 INFO - Running setup.py (path:/tmp/pip-vp0q54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:56:02 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)) 14:56:02 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)) 14:56:02 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)) 14:56:02 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)) 14:56:02 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)) 14:56:02 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)) 14:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:04 INFO - Downloading blessings-1.6.tar.gz 14:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:56:04 INFO - Installing collected packages: blessings 14:56:04 INFO - Running setup.py install for blessings 14:56:04 INFO - Successfully installed blessings 14:56:04 INFO - Cleaning up... 14:56:04 INFO - Return code: 0 14:56:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:05 INFO - Reading from file tmpfile_stdout 14:56:05 INFO - Current package versions: 14:56:05 INFO - argparse == 1.2.1 14:56:05 INFO - blessings == 1.6 14:56:05 INFO - blobuploader == 1.2.4 14:56:05 INFO - docopt == 0.6.1 14:56:05 INFO - functools32 == 3.2.3-2 14:56:05 INFO - jsonschema == 2.5.1 14:56:05 INFO - manifestparser == 1.1 14:56:05 INFO - mozInstall == 1.12 14:56:05 INFO - mozcrash == 0.17 14:56:05 INFO - mozdebug == 0.1 14:56:05 INFO - mozdevice == 0.48 14:56:05 INFO - mozfile == 1.2 14:56:05 INFO - mozhttpd == 0.7 14:56:05 INFO - mozinfo == 0.9 14:56:05 INFO - mozleak == 0.1 14:56:05 INFO - mozlog == 3.2 14:56:05 INFO - moznetwork == 0.27 14:56:05 INFO - mozprocess == 0.22 14:56:05 INFO - mozprofile == 0.28 14:56:05 INFO - mozrunner == 6.11 14:56:05 INFO - mozscreenshot == 0.1 14:56:05 INFO - mozsystemmonitor == 0.3 14:56:05 INFO - moztest == 0.7 14:56:05 INFO - mozversion == 1.4 14:56:05 INFO - psutil == 3.1.1 14:56:05 INFO - requests == 1.2.3 14:56:05 INFO - wsgiref == 0.1.2 14:56:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 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 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:56:05 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 14:56:05 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 14:56:05 INFO - Using env: {'DISPLAY': ':0', 14:56:05 INFO - 'HOME': '/home/cltbld', 14:56:05 INFO - 'LANG': 'en_US.UTF-8', 14:56:05 INFO - 'LANGUAGE': 'en_US:en', 14:56:05 INFO - 'LOGNAME': 'cltbld', 14:56:05 INFO - 'MAIL': '/var/mail/cltbld', 14:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:05 INFO - 'MOZ_NO_REMOTE': '1', 14:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:05 INFO - 'NO_EM_RESTART': '1', 14:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:05 INFO - 'PWD': '/builds/slave/test', 14:56:05 INFO - 'SHELL': '/bin/bash', 14:56:05 INFO - 'SHLVL': '1', 14:56:05 INFO - 'TERM': 'linux', 14:56:05 INFO - 'TMOUT': '86400', 14:56:05 INFO - 'USER': 'cltbld', 14:56:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:05 INFO - '_': '/tools/buildbot/bin/python'} 14:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 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)) 14:56:05 INFO - Cleaning up... 14:56:05 INFO - Return code: 0 14:56:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:56:05 INFO - Using env: {'DISPLAY': ':0', 14:56:05 INFO - 'HOME': '/home/cltbld', 14:56:05 INFO - 'LANG': 'en_US.UTF-8', 14:56:05 INFO - 'LANGUAGE': 'en_US:en', 14:56:05 INFO - 'LOGNAME': 'cltbld', 14:56:05 INFO - 'MAIL': '/var/mail/cltbld', 14:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:05 INFO - 'MOZ_NO_REMOTE': '1', 14:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:05 INFO - 'NO_EM_RESTART': '1', 14:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:05 INFO - 'PWD': '/builds/slave/test', 14:56:05 INFO - 'SHELL': '/bin/bash', 14:56:05 INFO - 'SHLVL': '1', 14:56:05 INFO - 'TERM': 'linux', 14:56:05 INFO - 'TMOUT': '86400', 14:56:05 INFO - 'USER': 'cltbld', 14:56:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:05 INFO - '_': '/tools/buildbot/bin/python'} 14:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:56:05 INFO - Cleaning up... 14:56:05 INFO - Return code: 0 14:56:05 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:56:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1659d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11f38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12be350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, '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': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', '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 14:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:56:05 INFO - Using env: {'DISPLAY': ':0', 14:56:05 INFO - 'HOME': '/home/cltbld', 14:56:05 INFO - 'LANG': 'en_US.UTF-8', 14:56:05 INFO - 'LANGUAGE': 'en_US:en', 14:56:05 INFO - 'LOGNAME': 'cltbld', 14:56:05 INFO - 'MAIL': '/var/mail/cltbld', 14:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:05 INFO - 'MOZ_NO_REMOTE': '1', 14:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:05 INFO - 'NO_EM_RESTART': '1', 14:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:05 INFO - 'PWD': '/builds/slave/test', 14:56:05 INFO - 'SHELL': '/bin/bash', 14:56:05 INFO - 'SHLVL': '1', 14:56:05 INFO - 'TERM': 'linux', 14:56:05 INFO - 'TMOUT': '86400', 14:56:05 INFO - 'USER': 'cltbld', 14:56:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:05 INFO - '_': '/tools/buildbot/bin/python'} 14:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:56:05 INFO - Downloading/unpacking flake8 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:56:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:56:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56: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 14:56:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:56:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:56:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:56:08 INFO - no previously-included directories found matching 'docs/_build' 14:56:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:56:08 INFO - Running setup.py install for pep8 14:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:56:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:56:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:56:08 INFO - no previously-included directories found matching 'docs/_build' 14:56:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:56:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:56:08 INFO - Cleaning up... 14:56:08 INFO - Return code: 0 14:56:08 INFO - Running post-action listener: _resource_record_post_action 14:56:08 INFO - Running post-action listener: _start_resource_monitoring 14:56:08 INFO - Starting resource monitoring. 14:56:08 INFO - ##### 14:56:08 INFO - ##### Finished create-virtualenv step (success) 14:56:08 INFO - ##### 14:56:08 INFO - ##### 14:56:08 INFO - ##### Running install step. 14:56:08 INFO - ##### 14:56:08 INFO - Running pre-action listener: _resource_record_pre_action 14:56:08 INFO - Running main action method: install 14:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:56:08 INFO - Reading from file tmpfile_stdout 14:56:08 INFO - Detecting whether we're running mozinstall >=1.0... 14:56:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:56:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:56:09 INFO - Reading from file tmpfile_stdout 14:56:09 INFO - Output received: 14:56:09 INFO - Usage: mozinstall [options] installer 14:56:09 INFO - Options: 14:56:09 INFO - -h, --help show this help message and exit 14:56:09 INFO - -d DEST, --destination=DEST 14:56:09 INFO - Directory to install application into. [default: 14:56:09 INFO - "/builds/slave/test"] 14:56:09 INFO - --app=APP Application being installed. [default: firefox] 14:56:09 INFO - mkdir: /builds/slave/test/build/application 14:56:09 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'] 14:56:09 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 14:56:25 INFO - Reading from file tmpfile_stdout 14:56:25 INFO - Output received: 14:56:25 INFO - /builds/slave/test/build/application/firefox/firefox 14:56:25 INFO - Running post-action listener: _resource_record_post_action 14:56:25 INFO - ##### 14:56:25 INFO - ##### Finished install step (success) 14:56:25 INFO - ##### 14:56:25 INFO - ##### 14:56:25 INFO - ##### Running run-tests step. 14:56:25 INFO - ##### 14:56:25 INFO - Running pre-action listener: _resource_record_pre_action 14:56:25 INFO - Running main action method: run_tests 14:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:56:25 INFO - Python 2.7.3 14:56:25 INFO - Return code: 0 14:56:25 INFO - grabbing minidump binary from tooltool 14:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:56:25 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 0x134d1c0>, '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 0x134e0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x134e550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:56:25 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 14:56:25 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 14:56:25 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 14:56:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:56:25 INFO - Return code: 0 14:56:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:56:26 INFO - Return code: 0 14:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:56:26 INFO - Using env: {'DISPLAY': ':0', 14:56:26 INFO - 'HOME': '/home/cltbld', 14:56:26 INFO - 'LANG': 'en_US.UTF-8', 14:56:26 INFO - 'LANGUAGE': 'en_US:en', 14:56:26 INFO - 'LOGNAME': 'cltbld', 14:56:26 INFO - 'MAIL': '/var/mail/cltbld', 14:56:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:56:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:56:26 INFO - 'MOZ_NO_REMOTE': '1', 14:56:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:56:26 INFO - 'NO_EM_RESTART': '1', 14:56:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:56:26 INFO - 'PWD': '/builds/slave/test', 14:56:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:56:26 INFO - 'SHELL': '/bin/bash', 14:56:26 INFO - 'SHLVL': '1', 14:56:26 INFO - 'TERM': 'linux', 14:56:26 INFO - 'TMOUT': '86400', 14:56:26 INFO - 'USER': 'cltbld', 14:56:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059', 14:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:56:26 INFO - '_': '/tools/buildbot/bin/python'} 14:56:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:56:26 INFO - mozversion application_buildid: 20160624134259 14:56:26 INFO - mozversion application_changeset: 0cfc0fa7df034a592eb0ef580e0041a5c037bfa3 14:56:26 INFO - mozversion application_display_name: Nightly 14:56:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:56:26 INFO - mozversion application_name: Firefox 14:56:26 INFO - mozversion application_remotingname: firefox 14:56:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:56:26 INFO - mozversion application_vendor: Mozilla 14:56:26 INFO - mozversion application_version: 50.0a1 14:56:26 INFO - mozversion platform_buildid: 20160624134259 14:56:26 INFO - mozversion platform_changeset: 0cfc0fa7df034a592eb0ef580e0041a5c037bfa3 14:56:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:56:26 INFO - mozversion platform_version: 50.0a1 14:56:26 INFO - using testdate: 1466805386 14:56:26 INFO - actual date: 1466805386 14:56:26 INFO - starting webserver on 'localhost:48205' 14:56:26 INFO - SUITE-START | Running 2 tests 14:56:26 INFO - TEST-START | dromaeo_css 14:56:26 INFO - operating with platform_type : linux_ 14:56:26 INFO - Initialising browser for dromaeo_css test... 14:56:26 INFO - TEST-INFO | started process 15786 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepLODE/profile http://localhost:48205/getInfo.html) 14:56:30 INFO - PROCESS | 15786 | __metrics Screen width/height:1600/1200 14:56:30 INFO - PROCESS | 15786 | colorDepth:24 14:56:30 INFO - PROCESS | 15786 | Browser inner width/height: 1024/697 14:56:30 INFO - PROCESS | 15786 | __metrics 14:56:31 INFO - PROCESS | 15786 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:56:32 INFO - TEST-INFO | 15786: exit 0 14:56:32 INFO - Browser initialized. 14:56:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:56:32 INFO - TEST-INFO | started process 15868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpepLODE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:56:44 INFO - PROCESS | 15868 | RSS: Main: 176001024 14:56:44 INFO - PROCESS | 15868 | 14:57:36 INFO - PROCESS | 15868 | 1466805456777 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] 14:59:48 INFO - PROCESS | 15868 | Cycle 1(1): loaded http://localhost:48205/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48205/tests/dromaeo/cssquery-ext.html) 14:59:49 INFO - PROCESS | 15868 | RSS: Main: 285958144 14:59:49 INFO - PROCESS | 15868 | 15:02:52 INFO - PROCESS | 15868 | Cycle 1(1): loaded http://localhost:48205/tests/dromaeo/cssquery-ext.html (next: http://localhost:48205/tests/dromaeo/cssquery-jquery.html) 15:02:52 INFO - PROCESS | 15868 | RSS: Main: 260243456 15:02:52 INFO - PROCESS | 15868 | 15:05:55 INFO - PROCESS | 15868 | Cycle 1(1): loaded http://localhost:48205/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48205/tests/dromaeo/cssquery-mootools.html) 15:05:55 INFO - PROCESS | 15868 | RSS: Main: 258551808 15:05:55 INFO - PROCESS | 15868 | 15:08:57 INFO - PROCESS | 15868 | Cycle 1(1): loaded http://localhost:48205/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48205/tests/dromaeo/cssquery-prototype.html) 15:08:58 INFO - PROCESS | 15868 | RSS: Main: 254259200 15:08:58 INFO - PROCESS | 15868 | 15:12:01 INFO - PROCESS | 15868 | Cycle 1(1): loaded http://localhost:48205/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48205/tests/dromaeo/cssquery-yui.html) 15:12:02 INFO - PROCESS | 15868 | RSS: Main: 223412224 15:12:02 INFO - PROCESS | 15868 | 15:15:04 INFO - PROCESS | 15868 | Cycle 1(1): loaded http://localhost:48205/tests/dromaeo/cssquery-yui.html (next: http://localhost:48205/tests/dromaeo/cssquery-dojo.html) 15:15:05 INFO - PROCESS | 15868 | RSS: Main: 291450880 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | __start_tp_report 15:15:05 INFO - PROCESS | 15868 | _x_x_mozilla_page_load 15:15:05 INFO - PROCESS | 15868 | _x_x_mozilla_page_load_details 15:15:05 INFO - PROCESS | 15868 | |i|pagename|runs| 15:15:05 INFO - PROCESS | 15868 | |0;dojo.html;2605.8175927685056;2621.6329713840055;2636.0773729194784;2648.8543130127837;2651.840889546626;4621.0757848430285;4710.199266124767;4744.6915950463235;4835.2505361668955;4886.951130488698;4683.625309975202;4701.529847015297;4746.3117847912035;4794.664373493857;4794.688345257556;4281.1437712457555;4317.330813723878;4376.649868010568;4395.362672412498;4495.370648109268;4402.559744025604;4424.579664931843;4427.11457708458;4462.776861156945;4481.5070342262325;4302.677299202573;4310.762908040057;4341.891452713676;4348.956510434887;4423.823047078129;4312.482502099737;4315.956840431587;4317.050248945227;4366.694331396771;4383.452068491439;4309.332053531708;4328.32910898808;4335.024619460628;4358.738475691437;4359.149965756678;4671.719696818168;4695.413073365829;4699.765011749433;4738.597219236369;4772.80908763649;5106.4638212987475;5154.226865970135;5206.76569554371;5208.765605547759;5211.478852114796;5169.405518365398;5176;5229.267902493654;5237.083510385705;5240.187770895517;4666.62666986647;4725;4773.689710168828;4812.422509298906;4853.538913803183;5261.210818377274;5264.157734762496;5280.049591073644;5295.947040529545;5305.920411193835;5062.038212739568;5066.594672426197;5106.923396149061;5108.386993560796;5116.360454943132;5010.49895010496;5102.795888164506;5118.795248190105;5131.79472821083;5133.332666753298;5106.412762532282;5109.259157422227;5124.7950081996305;5124.795008199705;5134.2812006319145;5105.463926287761;5105.8723531912;5106.591472682177;5110.156824124052;5149.6910185389;4164;4205.957940420557;4209.326507758744;4241.215375155606;4287.121140166259;3760.7367484276383;3772.2832661794173;3772.603876592973;3810.142717888453;3820.789856557916;4473.843415480443;4484.349769283501;4489.842855500107;4533.909321813545;4537.2059889519205;4943.950560494349;4997.9750101249265;5087.821926232564;5160.638755287169;5217.295665085165;4461.955380446219;4498.482674492409;4499.257622492318;4519.525449827786;4535.31970204472;4646.698725439947;4658.627309815207;4665.323528088408;4670.299455081697;4688.179568575486;4683.578477937002;4735.242361222188;4811.109944660249;4819.421669399694;4822.68652537584;5090.618203634816;5188.558972487381;5195.844124676266;5197.8440646780655;5236.10986132366;4853.417589889236;4855.247436647325;4858.441279252931;4860.708357498562;4897.755112244445;4926.729029903389;5079.5428411443145;5103;5103.132467480463;5131.512506311894;5226.111561034557;5231.686098834082;5235.842924712265;5252.290940722954;5287.735613219401;5051.469595692546;5069.340985671839;5071.13790655582;5078.771455284595;5123.436421993503;4854.854354369375;4858.1012512685265;4894.2658601210105;4908.190148625436;5052.317937078447;4815.036992601424;4830.8792280193275;4935.506449355035;4940.8764780880765;4950.480199579137;4988.725620090785;4996.175631020987;4997.8750531235555;5002.274670172732;5038.244263360525;4833.516648335279;4897.363342765418;4943.233798761198;4952;4983.8504844854715 15:15:05 INFO - PROCESS | 15868 | |1;ext.html;538.9755648511615;581.0441823200838;581.1805354450224;592.2005292854647;598.4972622996681;27920.16239512813;28613.284667883287;40194;41218.58781412185;41220.793896030555;38261.234775304474;42335.15329693404;42416.575834241645;42476.787616061956;42576.361354579705;7855.4893931894385;8018.639161237758;8028.277455029046;8032.236937490959;8034.879476807852;7747.9612601936915;7851.2933835954755;7854.057513098436;7854.332381747529;7854.332381747558;7849.882251766228;7893.723719669812;7898.052233731932;7902.920970790305;7903.604819759018;7844.254795794419;7880.172581878935;7885.842283154362;7887.211278872124;7887.645055972495;7847.607619618996;7906.802329941797;7908.051033875971;7912.327452166573;7915.089764677078;38949.22101557982;39320.80339598284;39348;39385.212295753925;39392.409113863316;2881.6974217707048;2958.5562165675105;2986.805857619248;3019.698030196963;3209.2618697699427;29665;29843.552346714816;29968.700312997025;29997.100086997423;30563.694363056307;3550.3609350317192;3592.604813470516;3608.548931383577;3631.8547258109643;3654.817259137059;263858;265096;265415;265455;267598.9999999981;29241.415171696448;52871.47128528742;53629.463705363225;53672.463275367525;53786.46213537815;31161;32649;32954.83522582372;33009.50485742716;33042.834785825915;12855.328807255184;13038.739225215442;13062.477500900048;13070.607881763563;13079.215247085205;10916.508757105948;10992.450377481095;11000.339979601249;11003.834942475869;11004.174686898514;7888.329491993245;7905.169957154531;7905.960470197727;7974.5215287082965;7985.401094917905;3086.4598695228246;3101.705337992887;3127.8123312601315;3131.2015436063657;3181.4114388837675;850.570461916728;907.4782000349825;983.9950800245953;991.1525645573075;1044.613493007592;27921.860390698323;28172.295692607848;28691.426171476873;29134.27164320909;29607.555886661718;841.9326453883674;950.277788880442;995.6017592962728;1006.3358183598936;1015.243643485608;14286.85713142876;14681.265936703123;14738.852611473962;14926.776098358534;14927.552173434815;381493;382961;383708;383752;384160;48159.75920120377;49143.754281228365;49172.50827491679;49179.508204917496;49186;1080.6163811846839;1155.4742592120565;1169.6841852699724;1209.4920133543933;1215.428748488209;27972.300692482037;28703.71296287094;29325;29877.10368688943;30043;43117.35323970205;43265.783671081444;43612.34581481217;43613.345799813666;43754;293104;294903;295239;295701;382264;25297.102717296646;25691;26028.73971260339;27058.72941270562;27141.321466963484;41979;42762;42879.785601071795;43111;43641.12717745691;35828.82085589555;36864.44703329399;36903.81548092242;37277;37563;35533.61260722205;36651;37007.814960925025;37071.81464092662;37484.43773343347;36105.45841812322;36191;36432.453513197856;36985.445218321205;37150;32048.839755801073;32286.515702264955;33533.49699754457;34049;34367.140821478664;25351.239772688015;25656;25661.74338256668;25917.481650367263;26065.348366290993 15:15:05 INFO - PROCESS | 15868 | |2;jquery.html;372.8415423445036;373.57785702156576;373.63010619486704;381.6736690129941;388.38441070902616;15826.920865395672;17096.829031709694;17975.820241797577;17986.910065449687;18061.36785212516;15356.846431535681;16201.513954581353;16228.43200487983;16241.593960151002;17002.40491582795;4616.33063205835;4750.85747427576;4788;4788.257820037899;4793.32893394925;3476.391631464496;3647.3981793004123;4671.416072990876;5224.164133738603;5532.28080349554;5545.445455454463;5589.189567512708;5602.439756024406;5606.131049687305;5607.607467477278;5078.289039534468;5374.596905232123;5378.489043540877;5476.123820188751;5577.414371490996;3389.5593572835373;4994.775235114393;5315.6013299002725;5354.3574771027725;5365.490278423544;11637.70905727355;11702.824457633142;11751.764964700658;11887.762244755142;20467.385978420672;1733.7226043832927;1738.713112336463;1822.17091223493;1890.6313268912568;1901.277514544478;8990.145936136056;9010.774730631721;9022.458652480873;9220;9273.258139348836;1604.7994000749907;1616.94340698075;1647.078667850721;1669.1403926977616;1724.724044152942;61714.69142654258;68771.65614171897;69487;70142.64928675375;71035.28964710287;15099.245037748069;15892.205389730467;16062.357505699641;16759.2458339375;16917.91541042287;28767.856160719064;29099.56350654742;29348.853255733586;29417.11748647544;29542.113736587937;8602.225799678059;8836.779080523038;8874.86687699685;9112.407693500034;9255.953720231355;7350.154732205758;7430.888536671954;7547;7625.23747625233;7637.809054773675;8480.44877083;8588.957055214809;8642.462707078834;8676.305895528343;8723.738287851374;2785.0895813874145;3194.1375828526166;3259.3481303739345;3311.6853898879567;3440.8795692150657;784.2667106255669;791.4459878085248;850.8808766772656;884.8407286688458;923.4413180026122;15593.830462715116;16373.099479528502;16610.6677866442;17351.47945561635;17470.213840377215;811.8619834628128;889.6930558957149;892.7098692924825;899.8245342158216;909.1817364372118;9057.547122643842;9322.20761235289;9431.90568094324;9783.822689930668;9795.657151999645;357026;357542;357885;358645;372563;64637;74530;76357.23642763612;77149;77527.61236193783;705.5131958948207;773.0723132241333;899.2850683706338;905.0858632780938;919.72868003939;14834.813214942995;15054.698906022037;15175.24123793828;15240;15444.613884652974;27645.723542764314;33077.66922330746;33105.33789324248;35837.82081089578;36198.27603447864;48237;50337.49662503328;50460;50908;51020.23469648032;6773.254941956282;6925.411340036153;7198.7840364789145;7277.2722727726805;7804.595172868938;7467.887981680171;8590.91409085901;8866.335024873031;11485.827712584485;11825.645230643095;9813.803723925625;9875.851862221929;10438.791224175322;10473.895261047292;10485.580576776843;10535.789284214427;10748.301360411548;10809.405482698527;10823.729406764895;11069.667909962714;10625.309354891908;10652.201084918817;10698.465076746288;10716.51775670081;10944.616938407118;6779.35596118368;6919.411849992807;7039.260877607778;7971.960140199262;8239.258466738022;9294.860577091215;9957.103860652576;10058.14505767018;10141.645042423776;10481.266311358131 15:15:05 INFO - PROCESS | 15868 | |3;mootools.html;1245.1035254616684;1365.9795103073452;1417.2701058954638;1486.138039936836;1713.4602600180942;6799.388055075042;7700.383969282458;7966.60166991651;7978.162292959236;8243.422960392774;8033.839323213532;8058.5164890106635;8079.838403231932;8089.959550202241;8106.108328083921;2175.477885307527;2194.9231776887814;2202.614542455072;2203.8457307988447;2205.0628482894786;2180.433087397272;2218.367765186922;2224.510607666311;2225.0209907640588;2234.519578290667;2098.4858709616165;2139.8288136949086;2164.7835216478306;2166.1010680567547;2170.739511258651;2123.0870725588147;2123.447903545074;2129.3292612826986;2129.936101916945;2136.995612062336;2081.198738485679;2148.785121487854;2152.9138834446603;2162.2107930605375;2162.48100455891;7884.250996155356;8017.078036025873;8131.837363252761;8149.755507334789;8163.469374490698;4674.205385084544;4735.266033764772;4741.691790033671;4748.6438517111355;4767.404074490689;2731.5356389413846;2855.4003659231585;2888.768898488116;2935.765138788892;2937.2069541223964;920.2316066084827;930.1767935377239;937.6718148647986;938.9859152112724;943.5895385507326;11098.722531936686;11198.944005280004;11219.551217951272;11232.831507527393;11233.60682376121;4011.0774521860135;4089.652379547772;4143.875683729493;4147.709660323749;4175.83296668136;8625.0943650917;8626.870596941051;8650.6972255972;8708.651653933899;8718.607662655195;4552.499225085238;4588.403507543998;4594.770261486912;4598.609118224921;4602.263637817933;3648.2703459308245;3818.3508803503473;3969.2858719917685;4261.10516791471;4375.978120109443;3447.3967055765143;3513.2446523997464;3544.929101418009;3619.94570081449;3624.583172935146;1037.2894567221326;1072.2119242356862;1081.1566977757204;1088.3306766338644;1091.49245600796;764.5183534373421;780.1808101493409;784.3803395317635;794.7615715285507;802.3821657323828;5228.712420816892;5330.866728331823;5356.116240820221;5421.430749771296;5433.891322173614;403.6871424645923;408.0899593905548;410.67351455592876;416.4877201042734;437.4772147283965;3539.94690079649;3623.202895363016;3653;3676.5955744868043;3753.849846006129;9531.998280361202;9888.50557472138;9953.054459826304;9958.15355694774;9962.103410692927;9823.214142868554;9850.655227067162;9851.852222216672;9867.11195992364;9870.703878883645;7017.333353331425;7281.089863767029;7283.599402032939;7367.152777430664;7504.287092726182;5686.630369026;5772.336181339199;5784.623999440023;5872.471477567039;5989.2812862456785;9005.279577633904;9236.122568355995;9383.202427793714;9395.24838012971;9413.341066125306;9329.393589416666;9521.047895210424;9587.328886977844;9604.231661467205;9655.710328690151;6283.717232724447;6736.090627765385;6788.321167883172;6942.097527321416;6974.442044636518;7809.531428114331;7854.136045035156;7875.527468351917;7909.762707118795;7921.485103468256;6658.966705166443;6794;6797.93202067973;6824.624645644339;7052.0832291801735;6484.610923344614;6507.60954342722;6540;6575.671216439063;6607.867842643216;6293.276273228637;6298.653574053471;6462.063000864942;6537.673116344069;6542.869142617026;4775.450823155243;4819.3012013258585;4834.830780922651;4890.510948905081;4902.117618828645;4828.324034635224;4844.297576851407;4846.224604063333;4903.534164254533;4947.134251506044 15:15:05 INFO - PROCESS | 15868 | |4;prototype.html;301.65460547672916;304.50365903577165;310.3792415169661;311.83784432095297;312.375249500998;4831.444383895853;4848.418189817223;4851.272309153629;4886.2914877342855;4893.535114164158;4759.738214398215;4846.563809257166;4881.609471242301;4887.364642596457;4898.167311557035;3889.1832715129785;3904.629060239273;3907.5115610548683;3910.4720862683457;3924.7448915820523;3760.341940160461;3855.460235567009;3871.748336358142;3909.354956432185;3912.1784425270725;3779.489768881207;3802.676772474343;3807.409851473012;3811.4092315690973;3830.655241028307;3832.7891965941863;3836.251930873481;3842.3852183650483;3853.5183102112237;3863.961360386388;3212.6305474870455;3260.6413294537583;3285.2608163163336;3365.3341595910183;3385.86456541738;4690.9530904690855;4691.202495575761;4709.529047095298;4710.26990816424;4726.291056341542;4117.3206420940505;4356.978215108936;4363.52001279859;4391.099824535962;4397.956020439787;4884.902301953976;5090.898182036375;5090.9236361454605;5093.363329583802;5107.7956881724685;3729.738918275722;3732.925341493155;3740.812959352049;3742.158014446755;3763.9837243944257;5111.572003298404;5357.383900851413;5365.946340536584;5366.651167674088;5373.1402975524115;3792.658660720493;3802.372608519563;3809.3714537101623;3811.8183363156954;3841.4237864320016;3885.611438856092;3885.86399476017;3891.8443262269193;3894.9610503895165;3906.160175562268;4346.47842258931;4369.868903932887;4376.518582955872;4386.4736231652405;4393.824247030147;4912.361393018885;5023.447420783711;5025.648204625714;5060.873478163002;5066.645334826527;1328.7708869295864;1341.7316536692701;1353.4992052940474;1356.952506662262;1357.8845798107272;837.2673910328463;863.3093525179831;864.8497498327209;868.4021400622884;870.1211776106178;3982.960170398259;4050.86575758788;4094.570070142592;4099.36459848718;4117.876463706094;4620.561046700558;4638.582527572535;4648.83729069481;4659.627229821606;4695.5304469552775;4041.9191616167514;4054.3107671695293;4067.471228740245;4073.429719839225;4098.52866920302;2372.430616651991;2449.5713250181147;2461.778439940414;2484.391324125601;2489.3154382544944;4371.453568303962;4393.20922234001;4415.587012156144;4417.624501917373;4433.977830110829;4646.697964632288;4724.362211101526;4731.367678151032;4756.952430475721;4797.808087676453;4163.770992595376;4344.652427805768;4418.204723149864;4430.911381772346;4441.7779111044965;4639.234526303258;4664.55686709762;4705.106359588896;4705.12955103307;4716.622670186308;4518.706284091523;4564.329867027826;4576.771161441848;4586.073848983368;4593.586577208067;4114.814833332447;4391.07787364657;4392.802323895368;4423.049044455457;4431.8670439886855;3455.06713187433;3464.5842498899283;3495.6154822968942;3512.5784905811465;3527.171114788074;4674.6260299176665;4686.437627484587;4697.295405689174;4717.834875779331;4720.922793970642;4466.731996080245;4491.326301054868;4534.682572219913;4569.977150114228;4750.619950404029;5091.701616087874;5105.719185444687;5111.693298402108;5120.233519435788;5153.149730294459;4999.625028122832;5038.748062596929;5042.142835717864;5043.2687260347775;5057.69653820772;4709.529047095263;4905.533974272581;5098.719570423514;5144.742762861767;5187.2478490619405;5080.898382032413;5095.541401273903;5102.1326374515675;5106.7957281709805;5107.9489205107475 15:15:05 INFO - PROCESS | 15868 | |5;yui.html;575.712143928036;661.8180000499859;675.5440077947386;677.8542613338132;679.9966000169997;12549.247045177284;13071.803922941152;13086.476540938364;13092.672683182926;13153.67115822105;13107.213567185976;13389.196648201114;13408.530701425452;13423.530176443826;13558.389872455738;796.4464697035562;800.0439474827583;807.3460496997451;809.2271880354277;809.704457872878;632.50348476446;776.5806464509159;808.737160422862;814.1532805881876;821.5358322547742;858.6393714639835;859.8839156713857;861.2937391339104;861.4271509446211;862.3403096631082;664.2261765043718;849.7663142635794;850.0819115355432;850.3282406898543;850.400467670294;594.9286085669704;610.4566935427473;614.5206738743786;616.8396216983572;620.203039094761;13521.526746563823;13649.795253071212;13690;13724.588262352145;13737.381817818123;12771.48914043437;13352.33238338089;13478.595642130751;13592.388342524511;13592.796108058386;10805.729856753565;11596.478158482889;11672.241304315192;11783.293002419796;12062.276263424223;4150.169966006781;4184.602462766033;4234.449521562208;4250.213710463543;4408.118376324715;57431.42568574302;57444.71277643585;57528;58007.12989305121;58172;10343.120834728981;10489.475526223658;10611.204159688054;11051.834222486668;11074.058705010004;17177.141142942804;17893.19480623375;19600.90199548993;19633.901830490755;19634.70547941782;7116.573005619679;7142.714291428389;7148.106486689164;7180.281971802778;7269.818254543678;3749.5875453700073;3854.903627409281;3876.612338766101;3915.2169566086327;3961.485006949136;2936.38335949453;3064.3258483134123;3064.8314342711365;3067.969320306813;3068.2789544457037;515.222014757711;516.7442116152454;528.1101344234976;536.4554976698654;537.4786457136571;515.5123708126968;527.8126265175885;546.1889094694376;572.7995201679379;581.6975172910147;8144.633491492897;8321.334293256525;8370.414071015091;8455.408121431563;8461.703840365557;606.6663335165641;607.5048835199299;609.713434685697;615.9568830181934;618.2766163588612;3647.452882067711;3915.099527108781;3945.309570825094;4019.658329042064;4077.6737860971643;94619;95007;96837;98458.507707461;99289;78749;80925.59537202277;81720;82463.58768206241;84328;46816.5318346819;53970.46029539733;72067;73744.89382659264;74388.62805685936;8348.499090054373;8479.448835825651;8504.744857654281;8538.829223415372;8881.42270752399;38910.221795564496;40712;43271.783641081594;43303.350449743906;43897;39470.40794388144;44794.552054480344;66162.33837661562;66438.66780666259;68252.658736706;11327.376994265394;11328.830067549157;11419.657410277705;11483.598074067368;11879.58421455245;13148.305147769757;13264.270465124511;13484.988625852904;13514.526991555249;13949.232792196526;10746.35521868659;11558.884411156117;11805.055595552507;11842.171048026556;11849.229800062969;11499;11535.538578456768;12234.388280586114;12280.938595306967;12665.936670316589;12022.606950942247;12326.137170398344;12479.126461147633;12788.360581970679;12909.225446473241;9400.95299523498;9436.292278079309;9632.22942164611;9662.3719458235;9775.364601300893;9269.44383337002;9857.802843942938;10106.444145572064;10230.897691022994;10252.948735256276 15:15:05 INFO - PROCESS | 15868 | __end_tp_report 15:15:05 INFO - PROCESS | 15868 | __start_cc_report 15:15:05 INFO - PROCESS | 15868 | _x_x_mozilla_cycle_collect,1023 15:15:05 INFO - PROCESS | 15868 | __end_cc_report 15:15:05 INFO - PROCESS | 15868 | __startTimestamp1466806505249__endTimestamp 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | ------- Summary: start ------- 15:15:05 INFO - PROCESS | 15868 | Number of tests: 6 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | [#0] dojo.html Cycles:165 Average:4735.27 Median:4853.54 stddev:515.53 (10.6%) stddev-sans-first:489.29 15:15:05 INFO - PROCESS | 15868 | Values: 2605.8 2621.6 2636.1 2648.9 2651.8 4621.1 4710.2 4744.7 4835.3 4887.0 4683.6 4701.5 4746.3 4794.7 4794.7 4281.1 4317.3 4376.6 4395.4 4495.4 4402.6 4424.6 4427.1 4462.8 4481.5 4302.7 4310.8 4341.9 4349.0 4423.8 4312.5 4316.0 4317.1 4366.7 4383.5 4309.3 4328.3 4335.0 4358.7 4359.1 4671.7 4695.4 4699.8 4738.6 4772.8 5106.5 5154.2 5206.8 5208.8 5211.5 5169.4 5176.0 5229.3 5237.1 5240.2 4666.6 4725.0 4773.7 4812.4 4853.5 5261.2 5264.2 5280.0 5295.9 5305.9 5062.0 5066.6 5106.9 5108.4 5116.4 5010.5 5102.8 5118.8 5131.8 5133.3 5106.4 5109.3 5124.8 5124.8 5134.3 5105.5 5105.9 5106.6 5110.2 5149.7 4164.0 4206.0 4209.3 4241.2 4287.1 3760.7 3772.3 3772.6 3810.1 3820.8 4473.8 4484.3 4489.8 4533.9 4537.2 4944.0 4998.0 5087.8 5160.6 5217.3 4462.0 4498.5 4499.3 4519.5 4535.3 4646.7 4658.6 4665.3 4670.3 4688.2 4683.6 4735.2 4811.1 4819.4 4822.7 5090.6 5188.6 5195.8 5197.8 5236.1 4853.4 4855.2 4858.4 4860.7 4897.8 4926.7 5079.5 5103.0 5103.1 5131.5 5226.1 5231.7 5235.8 5252.3 5287.7 5051.5 5069.3 5071.1 5078.8 5123.4 4854.9 4858.1 4894.3 4908.2 5052.3 4815.0 4830.9 4935.5 4940.9 4950.5 4988.7 4996.2 4997.9 5002.3 5038.2 4833.5 4897.4 4943.2 4952.0 4983.9 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | [#1] ext.html Cycles:180 Average:46585.30 Median:36757.72 stddev:85577.61 (232.8%) stddev-sans-first:85747.85 15:15:05 INFO - PROCESS | 15868 | Values: 539.0 581.0 581.2 592.2 598.5 27920.2 28613.3 40194.0 41218.6 41220.8 38261.2 42335.2 42416.6 42476.8 42576.4 7855.5 8018.6 8028.3 8032.2 8034.9 7748.0 7851.3 7854.1 7854.3 7854.3 7849.9 7893.7 7898.1 7902.9 7903.6 7844.3 7880.2 7885.8 7887.2 7887.6 7847.6 7906.8 7908.1 7912.3 7915.1 38949.2 39320.8 39348.0 39385.2 39392.4 2881.7 2958.6 2986.8 3019.7 3209.3 29665.0 29843.6 29968.7 29997.1 30563.7 3550.4 3592.6 3608.5 3631.9 3654.8 263858.0 265096.0 265415.0 265455.0 267599.0 29241.4 52871.5 53629.5 53672.5 53786.5 31161.0 32649.0 32954.8 33009.5 33042.8 12855.3 13038.7 13062.5 13070.6 13079.2 10916.5 10992.5 11000.3 11003.8 11004.2 7888.3 7905.2 7906.0 7974.5 7985.4 3086.5 3101.7 3127.8 3131.2 3181.4 850.6 907.5 984.0 991.2 1044.6 27921.9 28172.3 28691.4 29134.3 29607.6 841.9 950.3 995.6 1006.3 1015.2 14286.9 14681.3 14738.9 14926.8 14927.6 381493.0 382961.0 383708.0 383752.0 384160.0 48159.8 49143.8 49172.5 49179.5 49186.0 1080.6 1155.5 1169.7 1209.5 1215.4 27972.3 28703.7 29325.0 29877.1 30043.0 43117.4 43265.8 43612.3 43613.3 43754.0 293104.0 294903.0 295239.0 295701.0 382264.0 25297.1 25691.0 26028.7 27058.7 27141.3 41979.0 42762.0 42879.8 43111.0 43641.1 35828.8 36864.4 36903.8 37277.0 37563.0 35533.6 36651.0 37007.8 37071.8 37484.4 36105.5 36191.0 36432.5 36985.4 37150.0 32048.8 32286.5 33533.5 34049.0 34367.1 25351.2 25656.0 25661.7 25917.5 26065.3 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | [#2] jquery.html Cycles:180 Average:23750.22 Median:4790.79 stddev:59610.44 (1244.3%) stddev-sans-first:59751.82 15:15:05 INFO - PROCESS | 15868 | Values: 372.8 373.6 373.6 381.7 388.4 15826.9 17096.8 17975.8 17986.9 18061.4 15356.8 16201.5 16228.4 16241.6 17002.4 4616.3 4750.9 4788.0 4788.3 4793.3 3476.4 3647.4 4671.4 5224.2 5532.3 5545.4 5589.2 5602.4 5606.1 5607.6 5078.3 5374.6 5378.5 5476.1 5577.4 3389.6 4994.8 5315.6 5354.4 5365.5 11637.7 11702.8 11751.8 11887.8 20467.4 1733.7 1738.7 1822.2 1890.6 1901.3 8990.1 9010.8 9022.5 9220.0 9273.3 1604.8 1616.9 1647.1 1669.1 1724.7 61714.7 68771.7 69487.0 70142.6 71035.3 15099.2 15892.2 16062.4 16759.2 16917.9 28767.9 29099.6 29348.9 29417.1 29542.1 8602.2 8836.8 8874.9 9112.4 9256.0 7350.2 7430.9 7547.0 7625.2 7637.8 8480.4 8589.0 8642.5 8676.3 8723.7 2785.1 3194.1 3259.3 3311.7 3440.9 784.3 791.4 850.9 884.8 923.4 15593.8 16373.1 16610.7 17351.5 17470.2 811.9 889.7 892.7 899.8 909.2 9057.5 9322.2 9431.9 9783.8 9795.7 357026.0 357542.0 357885.0 358645.0 372563.0 64637.0 74530.0 76357.2 77149.0 77527.6 705.5 773.1 899.3 905.1 919.7 14834.8 15054.7 15175.2 15240.0 15444.6 27645.7 33077.7 33105.3 35837.8 36198.3 48237.0 50337.5 50460.0 50908.0 51020.2 6773.3 6925.4 7198.8 7277.3 7804.6 7467.9 8590.9 8866.3 11485.8 11825.6 9813.8 9875.9 10438.8 10473.9 10485.6 10535.8 10748.3 10809.4 10823.7 11069.7 10625.3 10652.2 10698.5 10716.5 10944.6 6779.4 6919.4 7039.3 7972.0 8239.3 9294.9 9957.1 10058.1 10141.6 10481.3 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | [#3] mootools.html Cycles:180 Average:5218.98 Median:5279.79 stddev:3000.59 (56.8%) stddev-sans-first:2994.15 15:15:05 INFO - PROCESS | 15868 | Values: 1245.1 1366.0 1417.3 1486.1 1713.5 6799.4 7700.4 7966.6 7978.2 8243.4 8033.8 8058.5 8079.8 8090.0 8106.1 2175.5 2194.9 2202.6 2203.8 2205.1 2180.4 2218.4 2224.5 2225.0 2234.5 2098.5 2139.8 2164.8 2166.1 2170.7 2123.1 2123.4 2129.3 2129.9 2137.0 2081.2 2148.8 2152.9 2162.2 2162.5 7884.3 8017.1 8131.8 8149.8 8163.5 4674.2 4735.3 4741.7 4748.6 4767.4 2731.5 2855.4 2888.8 2935.8 2937.2 920.2 930.2 937.7 939.0 943.6 11098.7 11198.9 11219.6 11232.8 11233.6 4011.1 4089.7 4143.9 4147.7 4175.8 8625.1 8626.9 8650.7 8708.7 8718.6 4552.5 4588.4 4594.8 4598.6 4602.3 3648.3 3818.4 3969.3 4261.1 4376.0 3447.4 3513.2 3544.9 3619.9 3624.6 1037.3 1072.2 1081.2 1088.3 1091.5 764.5 780.2 784.4 794.8 802.4 5228.7 5330.9 5356.1 5421.4 5433.9 403.7 408.1 410.7 416.5 437.5 3539.9 3623.2 3653.0 3676.6 3753.8 9532.0 9888.5 9953.1 9958.2 9962.1 9823.2 9850.7 9851.9 9867.1 9870.7 7017.3 7281.1 7283.6 7367.2 7504.3 5686.6 5772.3 5784.6 5872.5 5989.3 9005.3 9236.1 9383.2 9395.2 9413.3 9329.4 9521.0 9587.3 9604.2 9655.7 6283.7 6736.1 6788.3 6942.1 6974.4 7809.5 7854.1 7875.5 7909.8 7921.5 6659.0 6794.0 6797.9 6824.6 7052.1 6484.6 6507.6 6540.0 6575.7 6607.9 6293.3 6298.7 6462.1 6537.7 6542.9 4775.5 4819.3 4834.8 4890.5 4902.1 4828.3 4844.3 4846.2 4903.5 4947.1 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | [#4] prototype.html Cycles:180 Average:4070.88 Median:4426.98 stddev:1151.06 (26.0%) stddev-sans-first:1118.98 15:15:05 INFO - PROCESS | 15868 | Values: 301.7 304.5 310.4 311.8 312.4 4831.4 4848.4 4851.3 4886.3 4893.5 4759.7 4846.6 4881.6 4887.4 4898.2 3889.2 3904.6 3907.5 3910.5 3924.7 3760.3 3855.5 3871.7 3909.4 3912.2 3779.5 3802.7 3807.4 3811.4 3830.7 3832.8 3836.3 3842.4 3853.5 3864.0 3212.6 3260.6 3285.3 3365.3 3385.9 4691.0 4691.2 4709.5 4710.3 4726.3 4117.3 4357.0 4363.5 4391.1 4398.0 4884.9 5090.9 5090.9 5093.4 5107.8 3729.7 3732.9 3740.8 3742.2 3764.0 5111.6 5357.4 5365.9 5366.7 5373.1 3792.7 3802.4 3809.4 3811.8 3841.4 3885.6 3885.9 3891.8 3895.0 3906.2 4346.5 4369.9 4376.5 4386.5 4393.8 4912.4 5023.4 5025.6 5060.9 5066.6 1328.8 1341.7 1353.5 1357.0 1357.9 837.3 863.3 864.8 868.4 870.1 3983.0 4050.9 4094.6 4099.4 4117.9 4620.6 4638.6 4648.8 4659.6 4695.5 4041.9 4054.3 4067.5 4073.4 4098.5 2372.4 2449.6 2461.8 2484.4 2489.3 4371.5 4393.2 4415.6 4417.6 4434.0 4646.7 4724.4 4731.4 4757.0 4797.8 4163.8 4344.7 4418.2 4430.9 4441.8 4639.2 4664.6 4705.1 4705.1 4716.6 4518.7 4564.3 4576.8 4586.1 4593.6 4114.8 4391.1 4392.8 4423.0 4431.9 3455.1 3464.6 3495.6 3512.6 3527.2 4674.6 4686.4 4697.3 4717.8 4720.9 4466.7 4491.3 4534.7 4570.0 4750.6 5091.7 5105.7 5111.7 5120.2 5153.1 4999.6 5038.7 5042.1 5043.3 5057.7 4709.5 4905.5 5098.7 5144.7 5187.2 5080.9 5095.5 5102.1 5106.8 5107.9 15:15:05 INFO - PROCESS | 15868 | 15:15:05 INFO - PROCESS | 15868 | [#5] yui.html Cycles:180 Average:17218.30 Median:23665.88 stddev:24015.26 (101.5%) stddev-sans-first:24050.11 15:15:05 INFO - PROCESS | 15868 | Values: 575.7 661.8 675.5 677.9 680.0 12549.2 13071.8 13086.5 13092.7 13153.7 13107.2 13389.2 13408.5 13423.5 13558.4 796.4 800.0 807.3 809.2 809.7 632.5 776.6 808.7 814.2 821.5 858.6 859.9 861.3 861.4 862.3 664.2 849.8 850.1 850.3 850.4 594.9 610.5 614.5 616.8 620.2 13521.5 13649.8 13690.0 13724.6 13737.4 12771.5 13352.3 13478.6 13592.4 13592.8 10805.7 11596.5 11672.2 11783.3 12062.3 4150.2 4184.6 4234.4 4250.2 4408.1 57431.4 57444.7 57528.0 58007.1 58172.0 10343.1 10489.5 10611.2 11051.8 11074.1 17177.1 17893.2 19600.9 19633.9 19634.7 7116.6 7142.7 7148.1 7180.3 7269.8 3749.6 3854.9 3876.6 3915.2 3961.5 2936.4 3064.3 3064.8 3068.0 3068.3 515.2 516.7 528.1 536.5 537.5 515.5 527.8 546.2 572.8 581.7 8144.6 8321.3 8370.4 8455.4 8461.7 606.7 607.5 609.7 616.0 618.3 3647.5 3915.1 3945.3 4019.7 4077.7 94619.0 95007.0 96837.0 98458.5 99289.0 78749.0 80925.6 81720.0 82463.6 84328.0 46816.5 53970.5 72067.0 73744.9 74388.6 8348.5 8479.4 8504.7 8538.8 8881.4 38910.2 40712.0 43271.8 43303.4 43897.0 39470.4 44794.6 66162.3 66438.7 68252.7 11327.4 11328.8 11419.7 11483.6 11879.6 13148.3 13264.3 13485.0 13514.5 13949.2 10746.4 11558.9 11805.1 11842.2 11849.2 11499.0 11535.5 12234.4 12280.9 12665.9 12022.6 12326.1 12479.1 12788.4 12909.2 9401.0 9436.3 9632.2 9662.4 9775.4 9269.4 9857.8 10106.4 10230.9 10252.9 15:15:05 INFO - PROCESS | 15868 | -------- Summary: end -------- 15:15:05 INFO - PROCESS | 15868 | 15:15:06 INFO - TEST-INFO | 15868: exit 0 15:15:06 INFO - TEST-OK | dromaeo_css | took 1119735ms 15:15:06 INFO - TEST-START | kraken 15:15:06 INFO - operating with platform_type : linux_ 15:15:06 INFO - Initialising browser for kraken test... 15:15:06 INFO - TEST-INFO | started process 16052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5QzoQ/profile http://localhost:48205/getInfo.html) 15:15:10 INFO - PROCESS | 16052 | __metrics Screen width/height:1600/1200 15:15:10 INFO - PROCESS | 16052 | colorDepth:24 15:15:10 INFO - PROCESS | 16052 | Browser inner width/height: 1024/697 15:15:10 INFO - PROCESS | 16052 | __metrics 15:15:11 INFO - PROCESS | 16052 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:15:12 INFO - TEST-INFO | 16052: exit 0 15:15:12 INFO - Browser initialized. 15:15:12 INFO - Running cycle 1/1 for kraken test... 15:15:12 INFO - TEST-INFO | started process 16133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY5QzoQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:15:24 INFO - PROCESS | 16133 | RSS: Main: 175685632 15:15:24 INFO - PROCESS | 16133 | 15:15:27 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48205/tests/kraken/driver.html?testName=audio-beat-detection) 15:15:28 INFO - PROCESS | 16133 | RSS: Main: 233549824 15:15:28 INFO - PROCESS | 16133 | 15:15:30 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48205/tests/kraken/driver.html?testName=audio-dft) 15:15:31 INFO - PROCESS | 16133 | RSS: Main: 221396992 15:15:31 INFO - PROCESS | 16133 | 15:15:34 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48205/tests/kraken/driver.html?testName=audio-fft) 15:15:35 INFO - PROCESS | 16133 | RSS: Main: 287735808 15:15:35 INFO - PROCESS | 16133 | 15:15:37 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48205/tests/kraken/driver.html?testName=audio-oscillator) 15:15:38 INFO - PROCESS | 16133 | RSS: Main: 198356992 15:15:38 INFO - PROCESS | 16133 | 15:15:40 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48205/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:15:40 INFO - PROCESS | 16133 | RSS: Main: 202190848 15:15:40 INFO - PROCESS | 16133 | 15:15:44 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48205/tests/kraken/driver.html?testName=imaging-darkroom) 15:15:44 INFO - PROCESS | 16133 | RSS: Main: 238043136 15:15:44 INFO - PROCESS | 16133 | 15:15:48 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48205/tests/kraken/driver.html?testName=imaging-desaturate) 15:15:48 INFO - PROCESS | 16133 | RSS: Main: 238772224 15:15:48 INFO - PROCESS | 16133 | 15:15:51 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48205/tests/kraken/driver.html?testName=json-parse-financial) 15:15:52 INFO - PROCESS | 16133 | RSS: Main: 238804992 15:15:52 INFO - PROCESS | 16133 | 15:15:54 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48205/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:15:54 INFO - PROCESS | 16133 | RSS: Main: 227581952 15:15:54 INFO - PROCESS | 16133 | 15:15:56 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:15:57 INFO - PROCESS | 16133 | RSS: Main: 230871040 15:15:57 INFO - PROCESS | 16133 | 15:15:59 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:16:00 INFO - PROCESS | 16133 | RSS: Main: 236580864 15:16:00 INFO - PROCESS | 16133 | 15:16:02 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:16:03 INFO - PROCESS | 16133 | RSS: Main: 241922048 15:16:03 INFO - PROCESS | 16133 | 15:16:06 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:16:06 INFO - PROCESS | 16133 | RSS: Main: 241831936 15:16:06 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | Cycle 1(1): loaded http://localhost:48205/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48205/tests/kraken/driver.html?testName=ai-astar) 15:16:08 INFO - PROCESS | 16133 | RSS: Main: 285118464 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | __start_tp_report 15:16:08 INFO - PROCESS | 16133 | _x_x_mozilla_page_load 15:16:08 INFO - PROCESS | 16133 | _x_x_mozilla_page_load_details 15:16:08 INFO - PROCESS | 16133 | |i|pagename|runs| 15:16:08 INFO - PROCESS | 16133 | |0;ai-astar;103;113;114;113;112;112;112;112;113;113 15:16:08 INFO - PROCESS | 16133 | |1;audio-beat-detection;155;137;135;185;129;158;158;135;206;136 15:16:08 INFO - PROCESS | 16133 | |2;audio-dft;162;162;163;161;163;162;162;162;160;161 15:16:08 INFO - PROCESS | 16133 | |3;audio-fft;74;76;76;119;76;77;75;75;101;75 15:16:08 INFO - PROCESS | 16133 | |4;audio-oscillator;85;86;107;86;86;87;120;85;86;135 15:16:08 INFO - PROCESS | 16133 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;116;117;117 15:16:08 INFO - PROCESS | 16133 | |6;imaging-darkroom;146;147;147;147;148;147;147;146;145;146 15:16:08 INFO - PROCESS | 16133 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;94 15:16:08 INFO - PROCESS | 16133 | |8;json-parse-financial;65;64;63;64;63;65;63;64;64;64 15:16:08 INFO - PROCESS | 16133 | |9;json-stringify-tinderbox;64;65;65;65;65;64;65;65;64;70 15:16:08 INFO - PROCESS | 16133 | |10;stanford-crypto-aes;87;83;81;86;87;89;82;87;101;88 15:16:08 INFO - PROCESS | 16133 | |11;stanford-crypto-ccm;147;133;127;127;136;133;129;128;146;139 15:16:08 INFO - PROCESS | 16133 | |12;stanford-crypto-pbkdf2;172;171;174;174;173;170;169;169;175;167 15:16:08 INFO - PROCESS | 16133 | |13;stanford-crypto-sha256-iterative;69;67;70;67;66;69;68;66;67;69 15:16:08 INFO - PROCESS | 16133 | __end_tp_report 15:16:08 INFO - PROCESS | 16133 | __start_cc_report 15:16:08 INFO - PROCESS | 16133 | _x_x_mozilla_cycle_collect,1898 15:16:08 INFO - PROCESS | 16133 | __end_cc_report 15:16:08 INFO - PROCESS | 16133 | __startTimestamp1466806568985__endTimestamp 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | ------- Summary: start ------- 15:16:08 INFO - PROCESS | 16133 | Number of tests: 14 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.13 (2.8%) stddev-sans-first:0.71 15:16:08 INFO - PROCESS | 16133 | Values: 103.0 113.0 114.0 113.0 112.0 112.0 112.0 112.0 113.0 113.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#1] audio-beat-detection Cycles:10 Average:153.40 Median:156.50 stddev:25.07 (16.0%) stddev-sans-first:26.58 15:16:08 INFO - PROCESS | 16133 | Values: 155.0 137.0 135.0 185.0 129.0 158.0 158.0 135.0 206.0 136.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:16:08 INFO - PROCESS | 16133 | Values: 162.0 162.0 163.0 161.0 163.0 162.0 162.0 162.0 160.0 161.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.50 stddev:15.17 (20.1%) stddev-sans-first:15.79 15:16:08 INFO - PROCESS | 16133 | Values: 74.0 76.0 76.0 119.0 76.0 77.0 75.0 75.0 101.0 75.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:86.00 stddev:18.07 (21.0%) stddev-sans-first:18.70 15:16:08 INFO - PROCESS | 16133 | Values: 85.0 86.0 107.0 86.0 86.0 87.0 120.0 85.0 86.0 135.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:16:08 INFO - PROCESS | 16133 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 15:16:08 INFO - PROCESS | 16133 | Values: 146.0 147.0 147.0 147.0 148.0 147.0 147.0 146.0 145.0 146.0 15:16:08 INFO - PROCESS | 16133 | 15:16:08 INFO - PROCESS | 16133 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 15:16:08 INFO - PROCESS | 16133 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 15:16:08 INFO - PROCESS | 16133 | 15:16:09 INFO - PROCESS | 16133 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 15:16:09 INFO - PROCESS | 16133 | Values: 65.0 64.0 63.0 64.0 63.0 65.0 63.0 64.0 64.0 64.0 15:16:09 INFO - PROCESS | 16133 | 15:16:09 INFO - PROCESS | 16133 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:1.75 (2.7%) stddev-sans-first:1.80 15:16:09 INFO - PROCESS | 16133 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 70.0 15:16:09 INFO - PROCESS | 16133 | 15:16:09 INFO - PROCESS | 16133 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:5.57 (6.4%) stddev-sans-first:5.90 15:16:09 INFO - PROCESS | 16133 | Values: 87.0 83.0 81.0 86.0 87.0 89.0 82.0 87.0 101.0 88.0 15:16:09 INFO - PROCESS | 16133 | 15:16:09 INFO - PROCESS | 16133 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:134.50 stddev:7.46 (5.5%) stddev-sans-first:6.39 15:16:09 INFO - PROCESS | 16133 | Values: 147.0 133.0 127.0 127.0 136.0 133.0 129.0 128.0 146.0 139.0 15:16:09 INFO - PROCESS | 16133 | 15:16:09 INFO - PROCESS | 16133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.50 stddev:2.63 (1.5%) stddev-sans-first:2.78 15:16:09 INFO - PROCESS | 16133 | Values: 172.0 171.0 174.0 174.0 173.0 170.0 169.0 169.0 175.0 167.0 15:16:09 INFO - PROCESS | 16133 | 15:16:09 INFO - PROCESS | 16133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.40 (2.0%) stddev-sans-first:1.41 15:16:09 INFO - PROCESS | 16133 | Values: 69.0 67.0 70.0 67.0 66.0 69.0 68.0 66.0 67.0 69.0 15:16:09 INFO - PROCESS | 16133 | -------- Summary: end -------- 15:16:09 INFO - PROCESS | 16133 | 15:16:10 INFO - TEST-INFO | 16133: exit 0 15:16:10 INFO - TEST-OK | kraken | took 64019ms 15:16:10 INFO - SUITE-END | took 1183s 15:16:10 INFO - Completed test suite (00:19:44) 15:16:10 INFO - javascript benchmark 15:16:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2605.8175927685056, 2621.6329713840055, 2636.0773729194784, 2648.8543130127837, 2651.840889546626, 4621.0757848430285, 4710.199266124767, 4744.6915950463235, 4835.2505361668955, 4886.951130488698, 4683.625309975202, 4701.529847015297, 4746.3117847912035, 4794.664373493857, 4794.688345257556, 4281.1437712457555, 4317.330813723878, 4376.649868010568, 4395.362672412498, 4495.370648109268, 4402.559744025604, 4424.579664931843, 4427.11457708458, 4462.776861156945, 4481.5070342262325, 4302.677299202573, 4310.762908040057, 4341.891452713676, 4348.956510434887, 4423.823047078129, 4312.482502099737, 4315.956840431587, 4317.050248945227, 4366.694331396771, 4383.452068491439, 4309.332053531708, 4328.32910898808, 4335.024619460628, 4358.738475691437, 4359.149965756678, 4671.719696818168, 4695.413073365829, 4699.765011749433, 4738.597219236369, 4772.80908763649, 5106.4638212987475, 5154.226865970135, 5206.76569554371, 5208.765605547759, 5211.478852114796, 5169.405518365398, 5176.0, 5229.267902493654, 5237.083510385705, 5240.187770895517, 4666.62666986647, 4725.0, 4773.689710168828, 4812.422509298906, 4853.538913803183, 5261.210818377274, 5264.157734762496, 5280.049591073644, 5295.947040529545, 5305.920411193835, 5062.038212739568, 5066.594672426197, 5106.923396149061, 5108.386993560796, 5116.360454943132, 5010.49895010496, 5102.795888164506, 5118.795248190105, 5131.79472821083, 5133.332666753298, 5106.412762532282, 5109.259157422227, 5124.7950081996305, 5124.795008199705, 5134.2812006319145, 5105.463926287761, 5105.8723531912, 5106.591472682177, 5110.156824124052, 5149.6910185389, 4164.0, 4205.957940420557, 4209.326507758744, 4241.215375155606, 4287.121140166259, 3760.7367484276383, 3772.2832661794173, 3772.603876592973, 3810.142717888453, 3820.789856557916, 4473.843415480443, 4484.349769283501, 4489.842855500107, 4533.909321813545, 4537.2059889519205, 4943.950560494349, 4997.9750101249265, 5087.821926232564, 5160.638755287169, 5217.295665085165, 4461.955380446219, 4498.482674492409, 4499.257622492318, 4519.525449827786, 4535.31970204472, 4646.698725439947, 4658.627309815207, 4665.323528088408, 4670.299455081697, 4688.179568575486, 4683.578477937002, 4735.242361222188, 4811.109944660249, 4819.421669399694, 4822.68652537584, 5090.618203634816, 5188.558972487381, 5195.844124676266, 5197.8440646780655, 5236.10986132366, 4853.417589889236, 4855.247436647325, 4858.441279252931, 4860.708357498562, 4897.755112244445, 4926.729029903389, 5079.5428411443145, 5103.0, 5103.132467480463, 5131.512506311894, 5226.111561034557, 5231.686098834082, 5235.842924712265, 5252.290940722954, 5287.735613219401, 5051.469595692546, 5069.340985671839, 5071.13790655582, 5078.771455284595, 5123.436421993503, 4854.854354369375, 4858.1012512685265, 4894.2658601210105, 4908.190148625436, 5052.317937078447, 4815.036992601424, 4830.8792280193275, 4935.506449355035, 4940.8764780880765, 4950.480199579137, 4988.725620090785, 4996.175631020987, 4997.8750531235555, 5002.274670172732, 5038.244263360525, 4833.516648335279, 4897.363342765418, 4943.233798761198, 4952.0, 4983.8504844854715], "value": 4701.10673825651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9755648511615, 581.0441823200838, 581.1805354450224, 592.2005292854647, 598.4972622996681, 27920.16239512813, 28613.284667883287, 40194.0, 41218.58781412185, 41220.793896030555, 38261.234775304474, 42335.15329693404, 42416.575834241645, 42476.787616061956, 42576.361354579705, 7855.4893931894385, 8018.639161237758, 8028.277455029046, 8032.236937490959, 8034.879476807852, 7747.9612601936915, 7851.2933835954755, 7854.057513098436, 7854.332381747529, 7854.332381747558, 7849.882251766228, 7893.723719669812, 7898.052233731932, 7902.920970790305, 7903.604819759018, 7844.254795794419, 7880.172581878935, 7885.842283154362, 7887.211278872124, 7887.645055972495, 7847.607619618996, 7906.802329941797, 7908.051033875971, 7912.327452166573, 7915.089764677078, 38949.22101557982, 39320.80339598284, 39348.0, 39385.212295753925, 39392.409113863316, 2881.6974217707048, 2958.5562165675105, 2986.805857619248, 3019.698030196963, 3209.2618697699427, 29665.0, 29843.552346714816, 29968.700312997025, 29997.100086997423, 30563.694363056307, 3550.3609350317192, 3592.604813470516, 3608.548931383577, 3631.8547258109643, 3654.817259137059, 263858.0, 265096.0, 265415.0, 265455.0, 267598.9999999981, 29241.415171696448, 52871.47128528742, 53629.463705363225, 53672.463275367525, 53786.46213537815, 31161.0, 32649.0, 32954.83522582372, 33009.50485742716, 33042.834785825915, 12855.328807255184, 13038.739225215442, 13062.477500900048, 13070.607881763563, 13079.215247085205, 10916.508757105948, 10992.450377481095, 11000.339979601249, 11003.834942475869, 11004.174686898514, 7888.329491993245, 7905.169957154531, 7905.960470197727, 7974.5215287082965, 7985.401094917905, 3086.4598695228246, 3101.705337992887, 3127.8123312601315, 3131.2015436063657, 3181.4114388837675, 850.570461916728, 907.4782000349825, 983.9950800245953, 991.1525645573075, 1044.613493007592, 27921.860390698323, 28172.295692607848, 28691.426171476873, 29134.27164320909, 29607.555886661718, 841.9326453883674, 950.277788880442, 995.6017592962728, 1006.3358183598936, 1015.243643485608, 14286.85713142876, 14681.265936703123, 14738.852611473962, 14926.776098358534, 14927.552173434815, 381493.0, 382961.0, 383708.0, 383752.0, 384160.0, 48159.75920120377, 49143.754281228365, 49172.50827491679, 49179.508204917496, 49186.0, 1080.6163811846839, 1155.4742592120565, 1169.6841852699724, 1209.4920133543933, 1215.428748488209, 27972.300692482037, 28703.71296287094, 29325.0, 29877.10368688943, 30043.0, 43117.35323970205, 43265.783671081444, 43612.34581481217, 43613.345799813666, 43754.0, 293104.0, 294903.0, 295239.0, 295701.0, 382264.0, 25297.102717296646, 25691.0, 26028.73971260339, 27058.72941270562, 27141.321466963484, 41979.0, 42762.0, 42879.785601071795, 43111.0, 43641.12717745691, 35828.82085589555, 36864.44703329399, 36903.81548092242, 37277.0, 37563.0, 35533.61260722205, 36651.0, 37007.814960925025, 37071.81464092662, 37484.43773343347, 36105.45841812322, 36191.0, 36432.453513197856, 36985.445218321205, 37150.0, 32048.839755801073, 32286.515702264955, 33533.49699754457, 34049.0, 34367.140821478664, 25351.239772688015, 25656.0, 25661.74338256668, 25917.481650367263, 26065.348366290993], "value": 16587.51019706239, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.8415423445036, 373.57785702156576, 373.63010619486704, 381.6736690129941, 388.38441070902616, 15826.920865395672, 17096.829031709694, 17975.820241797577, 17986.910065449687, 18061.36785212516, 15356.846431535681, 16201.513954581353, 16228.43200487983, 16241.593960151002, 17002.40491582795, 4616.33063205835, 4750.85747427576, 4788.0, 4788.257820037899, 4793.32893394925, 3476.391631464496, 3647.3981793004123, 4671.416072990876, 5224.164133738603, 5532.28080349554, 5545.445455454463, 5589.189567512708, 5602.439756024406, 5606.131049687305, 5607.607467477278, 5078.289039534468, 5374.596905232123, 5378.489043540877, 5476.123820188751, 5577.414371490996, 3389.5593572835373, 4994.775235114393, 5315.6013299002725, 5354.3574771027725, 5365.490278423544, 11637.70905727355, 11702.824457633142, 11751.764964700658, 11887.762244755142, 20467.385978420672, 1733.7226043832927, 1738.713112336463, 1822.17091223493, 1890.6313268912568, 1901.277514544478, 8990.145936136056, 9010.774730631721, 9022.458652480873, 9220.0, 9273.258139348836, 1604.7994000749907, 1616.94340698075, 1647.078667850721, 1669.1403926977616, 1724.724044152942, 61714.69142654258, 68771.65614171897, 69487.0, 70142.64928675375, 71035.28964710287, 15099.245037748069, 15892.205389730467, 16062.357505699641, 16759.2458339375, 16917.91541042287, 28767.856160719064, 29099.56350654742, 29348.853255733586, 29417.11748647544, 29542.113736587937, 8602.225799678059, 8836.779080523038, 8874.86687699685, 9112.407693500034, 9255.953720231355, 7350.154732205758, 7430.888536671954, 7547.0, 7625.23747625233, 7637.809054773675, 8480.44877083, 8588.957055214809, 8642.462707078834, 8676.305895528343, 8723.738287851374, 2785.0895813874145, 3194.1375828526166, 3259.3481303739345, 3311.6853898879567, 3440.8795692150657, 784.2667106255669, 791.4459878085248, 850.8808766772656, 884.8407286688458, 923.4413180026122, 15593.830462715116, 16373.099479528502, 16610.6677866442, 17351.47945561635, 17470.213840377215, 811.8619834628128, 889.6930558957149, 892.7098692924825, 899.8245342158216, 909.1817364372118, 9057.547122643842, 9322.20761235289, 9431.90568094324, 9783.822689930668, 9795.657151999645, 357026.0, 357542.0, 357885.0, 358645.0, 372563.0, 64637.0, 74530.0, 76357.23642763612, 77149.0, 77527.61236193783, 705.5131958948207, 773.0723132241333, 899.2850683706338, 905.0858632780938, 919.72868003939, 14834.813214942995, 15054.698906022037, 15175.24123793828, 15240.0, 15444.613884652974, 27645.723542764314, 33077.66922330746, 33105.33789324248, 35837.82081089578, 36198.27603447864, 48237.0, 50337.49662503328, 50460.0, 50908.0, 51020.23469648032, 6773.254941956282, 6925.411340036153, 7198.7840364789145, 7277.2722727726805, 7804.595172868938, 7467.887981680171, 8590.91409085901, 8866.335024873031, 11485.827712584485, 11825.645230643095, 9813.803723925625, 9875.851862221929, 10438.791224175322, 10473.895261047292, 10485.580576776843, 10535.789284214427, 10748.301360411548, 10809.405482698527, 10823.729406764895, 11069.667909962714, 10625.309354891908, 10652.201084918817, 10698.465076746288, 10716.51775670081, 10944.616938407118, 6779.35596118368, 6919.411849992807, 7039.260877607778, 7971.960140199262, 8239.258466738022, 9294.860577091215, 9957.103860652576, 10058.14505767018, 10141.645042423776, 10481.266311358131], "value": 8510.001207507199, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1245.1035254616684, 1365.9795103073452, 1417.2701058954638, 1486.138039936836, 1713.4602600180942, 6799.388055075042, 7700.383969282458, 7966.60166991651, 7978.162292959236, 8243.422960392774, 8033.839323213532, 8058.5164890106635, 8079.838403231932, 8089.959550202241, 8106.108328083921, 2175.477885307527, 2194.9231776887814, 2202.614542455072, 2203.8457307988447, 2205.0628482894786, 2180.433087397272, 2218.367765186922, 2224.510607666311, 2225.0209907640588, 2234.519578290667, 2098.4858709616165, 2139.8288136949086, 2164.7835216478306, 2166.1010680567547, 2170.739511258651, 2123.0870725588147, 2123.447903545074, 2129.3292612826986, 2129.936101916945, 2136.995612062336, 2081.198738485679, 2148.785121487854, 2152.9138834446603, 2162.2107930605375, 2162.48100455891, 7884.250996155356, 8017.078036025873, 8131.837363252761, 8149.755507334789, 8163.469374490698, 4674.205385084544, 4735.266033764772, 4741.691790033671, 4748.6438517111355, 4767.404074490689, 2731.5356389413846, 2855.4003659231585, 2888.768898488116, 2935.765138788892, 2937.2069541223964, 920.2316066084827, 930.1767935377239, 937.6718148647986, 938.9859152112724, 943.5895385507326, 11098.722531936686, 11198.944005280004, 11219.551217951272, 11232.831507527393, 11233.60682376121, 4011.0774521860135, 4089.652379547772, 4143.875683729493, 4147.709660323749, 4175.83296668136, 8625.0943650917, 8626.870596941051, 8650.6972255972, 8708.651653933899, 8718.607662655195, 4552.499225085238, 4588.403507543998, 4594.770261486912, 4598.609118224921, 4602.263637817933, 3648.2703459308245, 3818.3508803503473, 3969.2858719917685, 4261.10516791471, 4375.978120109443, 3447.3967055765143, 3513.2446523997464, 3544.929101418009, 3619.94570081449, 3624.583172935146, 1037.2894567221326, 1072.2119242356862, 1081.1566977757204, 1088.3306766338644, 1091.49245600796, 764.5183534373421, 780.1808101493409, 784.3803395317635, 794.7615715285507, 802.3821657323828, 5228.712420816892, 5330.866728331823, 5356.116240820221, 5421.430749771296, 5433.891322173614, 403.6871424645923, 408.0899593905548, 410.67351455592876, 416.4877201042734, 437.4772147283965, 3539.94690079649, 3623.202895363016, 3653.0, 3676.5955744868043, 3753.849846006129, 9531.998280361202, 9888.50557472138, 9953.054459826304, 9958.15355694774, 9962.103410692927, 9823.214142868554, 9850.655227067162, 9851.852222216672, 9867.11195992364, 9870.703878883645, 7017.333353331425, 7281.089863767029, 7283.599402032939, 7367.152777430664, 7504.287092726182, 5686.630369026, 5772.336181339199, 5784.623999440023, 5872.471477567039, 5989.2812862456785, 9005.279577633904, 9236.122568355995, 9383.202427793714, 9395.24838012971, 9413.341066125306, 9329.393589416666, 9521.047895210424, 9587.328886977844, 9604.231661467205, 9655.710328690151, 6283.717232724447, 6736.090627765385, 6788.321167883172, 6942.097527321416, 6974.442044636518, 7809.531428114331, 7854.136045035156, 7875.527468351917, 7909.762707118795, 7921.485103468256, 6658.966705166443, 6794.0, 6797.93202067973, 6824.624645644339, 7052.0832291801735, 6484.610923344614, 6507.60954342722, 6540.0, 6575.671216439063, 6607.867842643216, 6293.276273228637, 6298.653574053471, 6462.063000864942, 6537.673116344069, 6542.869142617026, 4775.450823155243, 4819.3012013258585, 4834.830780922651, 4890.510948905081, 4902.117618828645, 4828.324034635224, 4844.297576851407, 4846.224604063333, 4903.534164254533, 4947.134251506044], "value": 4088.6081090645666, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.65460547672916, 304.50365903577165, 310.3792415169661, 311.83784432095297, 312.375249500998, 4831.444383895853, 4848.418189817223, 4851.272309153629, 4886.2914877342855, 4893.535114164158, 4759.738214398215, 4846.563809257166, 4881.609471242301, 4887.364642596457, 4898.167311557035, 3889.1832715129785, 3904.629060239273, 3907.5115610548683, 3910.4720862683457, 3924.7448915820523, 3760.341940160461, 3855.460235567009, 3871.748336358142, 3909.354956432185, 3912.1784425270725, 3779.489768881207, 3802.676772474343, 3807.409851473012, 3811.4092315690973, 3830.655241028307, 3832.7891965941863, 3836.251930873481, 3842.3852183650483, 3853.5183102112237, 3863.961360386388, 3212.6305474870455, 3260.6413294537583, 3285.2608163163336, 3365.3341595910183, 3385.86456541738, 4690.9530904690855, 4691.202495575761, 4709.529047095298, 4710.26990816424, 4726.291056341542, 4117.3206420940505, 4356.978215108936, 4363.52001279859, 4391.099824535962, 4397.956020439787, 4884.902301953976, 5090.898182036375, 5090.9236361454605, 5093.363329583802, 5107.7956881724685, 3729.738918275722, 3732.925341493155, 3740.812959352049, 3742.158014446755, 3763.9837243944257, 5111.572003298404, 5357.383900851413, 5365.946340536584, 5366.651167674088, 5373.1402975524115, 3792.658660720493, 3802.372608519563, 3809.3714537101623, 3811.8183363156954, 3841.4237864320016, 3885.611438856092, 3885.86399476017, 3891.8443262269193, 3894.9610503895165, 3906.160175562268, 4346.47842258931, 4369.868903932887, 4376.518582955872, 4386.4736231652405, 4393.824247030147, 4912.361393018885, 5023.447420783711, 5025.648204625714, 5060.873478163002, 5066.645334826527, 1328.7708869295864, 1341.7316536692701, 1353.4992052940474, 1356.952506662262, 1357.8845798107272, 837.2673910328463, 863.3093525179831, 864.8497498327209, 868.4021400622884, 870.1211776106178, 3982.960170398259, 4050.86575758788, 4094.570070142592, 4099.36459848718, 4117.876463706094, 4620.561046700558, 4638.582527572535, 4648.83729069481, 4659.627229821606, 4695.5304469552775, 4041.9191616167514, 4054.3107671695293, 4067.471228740245, 4073.429719839225, 4098.52866920302, 2372.430616651991, 2449.5713250181147, 2461.778439940414, 2484.391324125601, 2489.3154382544944, 4371.453568303962, 4393.20922234001, 4415.587012156144, 4417.624501917373, 4433.977830110829, 4646.697964632288, 4724.362211101526, 4731.367678151032, 4756.952430475721, 4797.808087676453, 4163.770992595376, 4344.652427805768, 4418.204723149864, 4430.911381772346, 4441.7779111044965, 4639.234526303258, 4664.55686709762, 4705.106359588896, 4705.12955103307, 4716.622670186308, 4518.706284091523, 4564.329867027826, 4576.771161441848, 4586.073848983368, 4593.586577208067, 4114.814833332447, 4391.07787364657, 4392.802323895368, 4423.049044455457, 4431.8670439886855, 3455.06713187433, 3464.5842498899283, 3495.6154822968942, 3512.5784905811465, 3527.171114788074, 4674.6260299176665, 4686.437627484587, 4697.295405689174, 4717.834875779331, 4720.922793970642, 4466.731996080245, 4491.326301054868, 4534.682572219913, 4569.977150114228, 4750.619950404029, 5091.701616087874, 5105.719185444687, 5111.693298402108, 5120.233519435788, 5153.149730294459, 4999.625028122832, 5038.748062596929, 5042.142835717864, 5043.2687260347775, 5057.69653820772, 4709.529047095263, 4905.533974272581, 5098.719570423514, 5144.742762861767, 5187.2478490619405, 5080.898382032413, 5095.541401273903, 5102.1326374515675, 5106.7957281709805, 5107.9489205107475], "value": 3713.0536329946135, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.712143928036, 661.8180000499859, 675.5440077947386, 677.8542613338132, 679.9966000169997, 12549.247045177284, 13071.803922941152, 13086.476540938364, 13092.672683182926, 13153.67115822105, 13107.213567185976, 13389.196648201114, 13408.530701425452, 13423.530176443826, 13558.389872455738, 796.4464697035562, 800.0439474827583, 807.3460496997451, 809.2271880354277, 809.704457872878, 632.50348476446, 776.5806464509159, 808.737160422862, 814.1532805881876, 821.5358322547742, 858.6393714639835, 859.8839156713857, 861.2937391339104, 861.4271509446211, 862.3403096631082, 664.2261765043718, 849.7663142635794, 850.0819115355432, 850.3282406898543, 850.400467670294, 594.9286085669704, 610.4566935427473, 614.5206738743786, 616.8396216983572, 620.203039094761, 13521.526746563823, 13649.795253071212, 13690.0, 13724.588262352145, 13737.381817818123, 12771.48914043437, 13352.33238338089, 13478.595642130751, 13592.388342524511, 13592.796108058386, 10805.729856753565, 11596.478158482889, 11672.241304315192, 11783.293002419796, 12062.276263424223, 4150.169966006781, 4184.602462766033, 4234.449521562208, 4250.213710463543, 4408.118376324715, 57431.42568574302, 57444.71277643585, 57528.0, 58007.12989305121, 58172.0, 10343.120834728981, 10489.475526223658, 10611.204159688054, 11051.834222486668, 11074.058705010004, 17177.141142942804, 17893.19480623375, 19600.90199548993, 19633.901830490755, 19634.70547941782, 7116.573005619679, 7142.714291428389, 7148.106486689164, 7180.281971802778, 7269.818254543678, 3749.5875453700073, 3854.903627409281, 3876.612338766101, 3915.2169566086327, 3961.485006949136, 2936.38335949453, 3064.3258483134123, 3064.8314342711365, 3067.969320306813, 3068.2789544457037, 515.222014757711, 516.7442116152454, 528.1101344234976, 536.4554976698654, 537.4786457136571, 515.5123708126968, 527.8126265175885, 546.1889094694376, 572.7995201679379, 581.6975172910147, 8144.633491492897, 8321.334293256525, 8370.414071015091, 8455.408121431563, 8461.703840365557, 606.6663335165641, 607.5048835199299, 609.713434685697, 615.9568830181934, 618.2766163588612, 3647.452882067711, 3915.099527108781, 3945.309570825094, 4019.658329042064, 4077.6737860971643, 94619.0, 95007.0, 96837.0, 98458.507707461, 99289.0, 78749.0, 80925.59537202277, 81720.0, 82463.58768206241, 84328.0, 46816.5318346819, 53970.46029539733, 72067.0, 73744.89382659264, 74388.62805685936, 8348.499090054373, 8479.448835825651, 8504.744857654281, 8538.829223415372, 8881.42270752399, 38910.221795564496, 40712.0, 43271.783641081594, 43303.350449743906, 43897.0, 39470.40794388144, 44794.552054480344, 66162.33837661562, 66438.66780666259, 68252.658736706, 11327.376994265394, 11328.830067549157, 11419.657410277705, 11483.598074067368, 11879.58421455245, 13148.305147769757, 13264.270465124511, 13484.988625852904, 13514.526991555249, 13949.232792196526, 10746.35521868659, 11558.884411156117, 11805.055595552507, 11842.171048026556, 11849.229800062969, 11499.0, 11535.538578456768, 12234.388280586114, 12280.938595306967, 12665.936670316589, 12022.606950942247, 12326.137170398344, 12479.126461147633, 12788.360581970679, 12909.225446473241, 9400.95299523498, 9436.292278079309, 9632.22942164611, 9662.3719458235, 9775.364601300893, 9269.44383337002, 9857.802843942938, 10106.444145572064, 10230.897691022994, 10252.948735256276], "value": 6648.39391815356, "unit": "score"}], "name": "dromaeo_css", "value": 6372.804536172406, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 112.0, 112.0, 112.0, 112.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 137.0, 135.0, 185.0, 129.0, 158.0, 158.0, 135.0, 206.0, 136.0], "value": 153.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 163.0, 162.0, 162.0, 162.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 119.0, 76.0, 77.0, 75.0, 75.0, 101.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 107.0, 86.0, 86.0, 87.0, 120.0, 85.0, 86.0, 135.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 146.0, 145.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 63.0, 65.0, 63.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 70.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 81.0, 86.0, 87.0, 89.0, 82.0, 87.0, 101.0, 88.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 133.0, 127.0, 127.0, 136.0, 133.0, 129.0, 128.0, 146.0, 139.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 174.0, 174.0, 173.0, 170.0, 169.0, 169.0, 175.0, 167.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 70.0, 67.0, 66.0, 69.0, 68.0, 66.0, 67.0, 69.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1553.8000000000002, "alertThreshold": 2.0}]} 15:16:10 INFO - Return code: 0 15:16:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:16:10 INFO - # TBPL SUCCESS # 15:16:10 INFO - Running post-action listener: _resource_record_post_action 15:16:10 INFO - ##### 15:16:10 INFO - ##### Finished run-tests step (success) 15:16:10 INFO - ##### 15:16:10 INFO - Running post-run listener: _resource_record_post_run 15:16:10 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 366489600; Read time: 16; Write time: 293100 15:16:10 INFO - TinderboxPrint: CPU usage
13.2% 15:16:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 15:16:10 INFO - TinderboxPrint: I/O write bytes / time
366,489,600 / 293,100 15:16:10 INFO - TinderboxPrint: CPU idle
8,321.9 (86.7%) 15:16:10 INFO - TinderboxPrint: CPU user
1,223.6 (12.8%) 15:16:10 INFO - TinderboxPrint: Swap in / out
0 / 0 15:16:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 72126464; Read time: 0; Write time: 33328 15:16:10 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 294363136; Read time: 16; Write time: 259772 15:16:11 INFO - Running post-run listener: _upload_blobber_files 15:16:11 INFO - Blob upload gear active. 15:16:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:16:11 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 15:16:11 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'] 15:16:11 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 15:16:11 INFO - (blobuploader) - INFO - Open directory for files ... 15:16:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:16:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:16:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:12 INFO - (blobuploader) - INFO - Done attempting. 15:16:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:16:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:16:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:13 INFO - (blobuploader) - INFO - Done attempting. 15:16:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:16:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:16:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:16:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:16:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:16:16 INFO - (blobuploader) - INFO - Done attempting. 15:16:16 INFO - (blobuploader) - INFO - Iteration through files over. 15:16:16 INFO - Return code: 0 15:16:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:16:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:16:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a539e25d3992cbfc3690b6dacd8e2bd0e37ab42a1d2651190ff9b9f0a8b99b0a7f00a7c7eb3e520fcc1eacb9ca331e4a426af66348384fcbaa78c6ea60274674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f414a086a43b25ba39b61b0c83564b22a0de360d45140dc67cc0a033f5f0494b75421c804fefe7eeb7e82ded1e6b169ce0fec0d39a29aa62ebce2a215bb34c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fea4be361ebc8737ab4dea3673dd124961196be61ee7fb9a03e53f65faeccd2fdfb71795c12c78e63827fa63cb752ad06e9e42a8ffaed23df6cb161e0c9d24a"} 15:16:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:16:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:16:16 INFO - Contents: 15:16:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a539e25d3992cbfc3690b6dacd8e2bd0e37ab42a1d2651190ff9b9f0a8b99b0a7f00a7c7eb3e520fcc1eacb9ca331e4a426af66348384fcbaa78c6ea60274674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f414a086a43b25ba39b61b0c83564b22a0de360d45140dc67cc0a033f5f0494b75421c804fefe7eeb7e82ded1e6b169ce0fec0d39a29aa62ebce2a215bb34c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fea4be361ebc8737ab4dea3673dd124961196be61ee7fb9a03e53f65faeccd2fdfb71795c12c78e63827fa63cb752ad06e9e42a8ffaed23df6cb161e0c9d24a"} 15:16:16 INFO - Running post-run listener: copy_logs_to_upload_dir 15:16:16 INFO - Copying logs to upload dir... 15:16:16 INFO - mkdir: /builds/slave/test/build/upload/logs 15:16:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1929.768465 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 9 secs) (at 2016-06-24 15:16:16.311294) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:16.318682) ========= 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=41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a539e25d3992cbfc3690b6dacd8e2bd0e37ab42a1d2651190ff9b9f0a8b99b0a7f00a7c7eb3e520fcc1eacb9ca331e4a426af66348384fcbaa78c6ea60274674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f414a086a43b25ba39b61b0c83564b22a0de360d45140dc67cc0a033f5f0494b75421c804fefe7eeb7e82ded1e6b169ce0fec0d39a29aa62ebce2a215bb34c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fea4be361ebc8737ab4dea3673dd124961196be61ee7fb9a03e53f65faeccd2fdfb71795c12c78e63827fa63cb752ad06e9e42a8ffaed23df6cb161e0c9d24a"} build_url:https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/BGYy3c27S22-Bi3r8qDWDA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a539e25d3992cbfc3690b6dacd8e2bd0e37ab42a1d2651190ff9b9f0a8b99b0a7f00a7c7eb3e520fcc1eacb9ca331e4a426af66348384fcbaa78c6ea60274674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f414a086a43b25ba39b61b0c83564b22a0de360d45140dc67cc0a033f5f0494b75421c804fefe7eeb7e82ded1e6b169ce0fec0d39a29aa62ebce2a215bb34c1c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7fea4be361ebc8737ab4dea3673dd124961196be61ee7fb9a03e53f65faeccd2fdfb71795c12c78e63827fa63cb752ad06e9e42a8ffaed23df6cb161e0c9d24a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:16.346818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:16.347150) ========= 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=41bf3e9aed84707956354da8000001c5-1466803069.824270-782330059 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-24 15:16:16.428996) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:16:16.432333) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-24 15:16:16.432641) ========= ========= Total master_lag: 0.19 =========