builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-066 starttime: 1466498785.71 results: success (0) buildid: 20160621004800 builduid: 1287937dc5f549abb92e0fe6cffc8be0 revision: be179bb8c58ff829b3c81cbc203833686dd3739e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.710182) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.710761) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.711073) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.762915) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.763276) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 01:46:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2016-06-21 01:46:25 (21.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134945 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.924302) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.924618) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018026 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:25.976851) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:46:25.977237) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev be179bb8c58ff829b3c81cbc203833686dd3739e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev be179bb8c58ff829b3c81cbc203833686dd3739e --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 01:46:26,119 truncating revision to first 12 chars 2016-06-21 01:46:26,119 Setting DEBUG logging. 2016-06-21 01:46:26,119 attempt 1/10 2016-06-21 01:46:26,120 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/be179bb8c58f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 01:46:27,066 unpacking tar archive at: fx-team-be179bb8c58f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283369 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 01:46:27.278280) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.278636) ========= script_repo_revision: be179bb8c58ff829b3c81cbc203833686dd3739e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.279069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.279356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 01:46:27.296731) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-21 01:46:27.297165) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:46:27 INFO - MultiFileLogger online at 20160621 01:46:27 in /builds/slave/test 01:46:27 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 01:46:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:46:27 INFO - {'append_to_log': False, 01:46:27 INFO - 'base_work_dir': '/builds/slave/test', 01:46:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:46:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:46:27 INFO - 'branch': 'Fx-Team-Non-PGO', 01:46:27 INFO - 'buildbot_json_path': 'buildprops.json', 01:46:27 INFO - 'config_files': ('talos/linux_config.py',), 01:46:27 INFO - 'default_actions': ('clobber', 01:46:27 INFO - 'read-buildbot-config', 01:46:27 INFO - 'download-and-extract', 01:46:27 INFO - 'populate-webroot', 01:46:27 INFO - 'create-virtualenv', 01:46:27 INFO - 'install', 01:46:27 INFO - 'run-tests'), 01:46:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:46:27 INFO - 'download_minidump_stackwalk': True, 01:46:27 INFO - 'download_symbols': 'ondemand', 01:46:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:46:27 INFO - 'tooltool.py': '/tools/tooltool.py', 01:46:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:46:27 INFO - '/tools/misc-python/virtualenv.py')}, 01:46:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:46:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:46:27 INFO - 'installer_path': 'installer.exe', 01:46:27 INFO - 'log_level': 'info', 01:46:27 INFO - 'log_name': 'talos', 01:46:27 INFO - 'log_to_console': True, 01:46:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:46:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:46:27 INFO - 'opt_config_files': (), 01:46:27 INFO - 'pip_index': False, 01:46:27 INFO - 'sps_profile': False, 01:46:27 INFO - 'sps_profile_interval': 0, 01:46:27 INFO - 'suite': 'dromaeojs', 01:46:27 INFO - 'system_bits': '32', 01:46:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:46:27 INFO - 'title': 'talos-linux64-ix-066', 01:46:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:46:27 INFO - 'use_talos_json': True, 01:46:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:46:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:46:27 INFO - 'work_dir': 'build'} 01:46:27 INFO - ##### 01:46:27 INFO - ##### Running clobber step. 01:46:27 INFO - ##### 01:46:27 INFO - Running pre-action listener: _resource_record_pre_action 01:46:27 INFO - Running main action method: clobber 01:46:27 INFO - rmtree: /builds/slave/test/build 01:46:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:46:27 INFO - Running post-action listener: _resource_record_post_action 01:46:27 INFO - ##### 01:46:27 INFO - ##### Finished clobber step (success) 01:46:27 INFO - ##### 01:46:27 INFO - ##### 01:46:27 INFO - ##### Running read-buildbot-config step. 01:46:27 INFO - ##### 01:46:27 INFO - Running pre-action listener: _resource_record_pre_action 01:46:27 INFO - Running main action method: read_buildbot_config 01:46:27 INFO - Using buildbot properties: 01:46:27 INFO - { 01:46:27 INFO - "project": "", 01:46:27 INFO - "product": "firefox", 01:46:27 INFO - "script_repo_revision": "production", 01:46:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:46:27 INFO - "repository": "", 01:46:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 01:46:27 INFO - "buildid": "20160621004800", 01:46:27 INFO - "pgo_build": "False", 01:46:27 INFO - "basedir": "/builds/slave/test", 01:46:27 INFO - "buildnumber": 1874, 01:46:27 INFO - "slavename": "talos-linux64-ix-066", 01:46:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:46:27 INFO - "platform": "ubuntu64_hw", 01:46:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:46:27 INFO - "branch": "fx-team", 01:46:27 INFO - "repo_path": "integration/fx-team", 01:46:27 INFO - "revision": "be179bb8c58ff829b3c81cbc203833686dd3739e", 01:46:27 INFO - "stage_platform": "linux64", 01:46:27 INFO - "builduid": "1287937dc5f549abb92e0fe6cffc8be0", 01:46:27 INFO - "slavebuilddir": "test" 01:46:27 INFO - } 01:46:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:46:27 INFO - Running post-action listener: _resource_record_post_action 01:46:27 INFO - ##### 01:46:27 INFO - ##### Finished read-buildbot-config step (success) 01:46:27 INFO - ##### 01:46:27 INFO - ##### 01:46:27 INFO - ##### Running download-and-extract step. 01:46:27 INFO - ##### 01:46:27 INFO - Running pre-action listener: _resource_record_pre_action 01:46:27 INFO - Running main action method: download_and_extract 01:46:27 INFO - mkdir: /builds/slave/test/build/tests 01:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:27 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:46:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:46:32 INFO - Downloaded 1361 bytes. 01:46:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:46:32 INFO - Using the following test package requirements: 01:46:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:46:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:46:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'jsshell-linux-x86_64.zip'], 01:46:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:46:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:46:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:46:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:46:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:46:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:46:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:46:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:32 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:33 INFO - Downloaded 22654960 bytes. 01:46:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:46:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:46:34 INFO - Return code: 0 01:46:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:34 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:46:39 INFO - Downloaded 22654960 bytes. 01:46:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:46:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:46:41 INFO - Return code: 0 01:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:41 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:46:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:46:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:46:42 INFO - Downloaded 14405384 bytes. 01:46:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:46:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:46:42 INFO - Return code: 0 01:46: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')]} 01:46:42 INFO - https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:46:44 INFO - Downloaded 56230407 bytes. 01:46:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:44 INFO - mkdir: /builds/slave/test/properties 01:46:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:46:44 INFO - Writing to file /builds/slave/test/properties/build_url 01:46:44 INFO - Contents: 01:46:44 INFO - build_url:https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:46:45 INFO - Running post-action listener: _resource_record_post_action 01:46:45 INFO - Running post-action listener: set_extra_try_arguments 01:46:45 INFO - ##### 01:46:45 INFO - ##### Finished download-and-extract step (success) 01:46:45 INFO - ##### 01:46:45 INFO - ##### 01:46:45 INFO - ##### Running populate-webroot step. 01:46:45 INFO - ##### 01:46:45 INFO - Running pre-action listener: _resource_record_pre_action 01:46:45 INFO - Running main action method: populate_webroot 01:46:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:46:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:46:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:46:45 INFO - '--tppagecycles', 01:46:45 INFO - '7'], 01:46:45 INFO - 'tests': ['tsvgm']}}, 01:46:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:46:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:46:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:46:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:46:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:46:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['damp', 'tps']}, 01:46:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'tests': ['damp', 'tps']}, 01:46:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['dromaeo_dom']}, 01:46:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:46:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['basic_compositor_video']}, 01:46:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:46:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['a11yr', 01:46:45 INFO - 'ts_paint', 01:46:45 INFO - 'tpaint', 01:46:45 INFO - 'sessionrestore', 01:46:45 INFO - 'sessionrestore_no_auto_restore', 01:46:45 INFO - 'tabpaint']}, 01:46:45 INFO - 'other-e10s': {'tests': ['a11yr', 01:46:45 INFO - 'ts_paint', 01:46:45 INFO - 'tpaint', 01:46:45 INFO - 'sessionrestore', 01:46:45 INFO - 'sessionrestore_no_auto_restore', 01:46:45 INFO - 'tabpaint']}, 01:46:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:46:45 INFO - 'ts_paint', 01:46:45 INFO - 'tpaint', 01:46:45 INFO - 'sessionrestore', 01:46:45 INFO - 'sessionrestore_no_auto_restore', 01:46:45 INFO - 'tabpaint']}, 01:46:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:46:45 INFO - 'ts_paint', 01:46:45 INFO - 'tpaint', 01:46:45 INFO - 'sessionrestore', 01:46:45 INFO - 'sessionrestore_no_auto_restore', 01:46:45 INFO - 'tabpaint']}, 01:46:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['a11yr', 01:46:45 INFO - 'ts_paint', 01:46:45 INFO - 'tpaint', 01:46:45 INFO - 'sessionrestore', 01:46:45 INFO - 'sessionrestore_no_auto_restore', 01:46:45 INFO - 'tabpaint']}, 01:46:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['a11yr', 01:46:45 INFO - 'ts_paint', 01:46:45 INFO - 'tpaint', 01:46:45 INFO - 'sessionrestore', 01:46:45 INFO - 'sessionrestore_no_auto_restore', 01:46:45 INFO - 'tabpaint']}, 01:46:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['tsvgx', 01:46:45 INFO - 'tsvgr_opacity', 01:46:45 INFO - 'tart', 01:46:45 INFO - 'tscrollx', 01:46:45 INFO - 'cart']}, 01:46:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:46:45 INFO - 'tsvgr_opacity', 01:46:45 INFO - 'tart', 01:46:45 INFO - 'tscrollx', 01:46:45 INFO - 'cart']}, 01:46:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'talos_options': ['--disable-e10s'], 01:46:45 INFO - 'tests': ['tp5o']}, 01:46:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'tests': ['tp5o']}, 01:46:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'talos_options': ['--disable-e10s', 01:46:45 INFO - '--xperf_path', 01:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:45 INFO - 'tests': ['tp5n']}, 01:46:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:46:45 INFO - 'talos_options': ['--xperf_path', 01:46:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:46:45 INFO - 'tests': ['tp5n']}}, 01:46:45 INFO - 'talos.zip': {'path': '', 01:46:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:46:45 INFO - Running post-action listener: _resource_record_post_action 01:46:45 INFO - ##### 01:46:45 INFO - ##### Finished populate-webroot step (success) 01:46:45 INFO - ##### 01:46:45 INFO - ##### 01:46:45 INFO - ##### Running create-virtualenv step. 01:46:45 INFO - ##### 01:46:45 INFO - Running pre-action listener: _resource_record_pre_action 01:46:45 INFO - Running main action method: create_virtualenv 01:46:45 INFO - Creating virtualenv /builds/slave/test/build/venv 01:46:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:46:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:46:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:46:45 INFO - Using real prefix '/usr' 01:46:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:46:46 INFO - Installing distribute.............................................................................................................................................................................................done. 01:46:48 INFO - Installing pip.................done. 01:46:48 INFO - Return code: 0 01:46:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:48 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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:46:48 INFO - Using env: {'DISPLAY': ':0', 01:46:48 INFO - 'HOME': '/home/cltbld', 01:46:48 INFO - 'LANG': 'en_US.UTF-8', 01:46:48 INFO - 'LANGUAGE': 'en_US:en', 01:46:48 INFO - 'LOGNAME': 'cltbld', 01:46:48 INFO - 'MAIL': '/var/mail/cltbld', 01:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:48 INFO - 'MOZ_NO_REMOTE': '1', 01:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:48 INFO - 'NO_EM_RESTART': '1', 01:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:48 INFO - 'PWD': '/builds/slave/test', 01:46:48 INFO - 'SHELL': '/bin/bash', 01:46:48 INFO - 'SHLVL': '1', 01:46:48 INFO - 'TERM': 'linux', 01:46:48 INFO - 'TMOUT': '86400', 01:46:48 INFO - 'USER': 'cltbld', 01:46:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:48 INFO - '_': '/tools/buildbot/bin/python'} 01:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:48 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:46:48 INFO - Cleaning up... 01:46:48 INFO - Return code: 0 01:46:48 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:48 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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:46:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:46:48 INFO - Using env: {'DISPLAY': ':0', 01:46:48 INFO - 'HOME': '/home/cltbld', 01:46:48 INFO - 'LANG': 'en_US.UTF-8', 01:46:48 INFO - 'LANGUAGE': 'en_US:en', 01:46:48 INFO - 'LOGNAME': 'cltbld', 01:46:48 INFO - 'MAIL': '/var/mail/cltbld', 01:46:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:48 INFO - 'MOZ_NO_REMOTE': '1', 01:46:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:48 INFO - 'NO_EM_RESTART': '1', 01:46:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:48 INFO - 'PWD': '/builds/slave/test', 01:46:48 INFO - 'SHELL': '/bin/bash', 01:46:48 INFO - 'SHLVL': '1', 01:46:48 INFO - 'TERM': 'linux', 01:46:48 INFO - 'TMOUT': '86400', 01:46:48 INFO - 'USER': 'cltbld', 01:46:48 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:46:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:48 INFO - '_': '/tools/buildbot/bin/python'} 01:46:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:48 INFO - Downloading/unpacking psutil>=3.1.1 01:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:46:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:50 INFO - Installing collected packages: psutil 01:46:50 INFO - Running setup.py install for psutil 01:46:50 INFO - building 'psutil._psutil_linux' extension 01:46:50 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:46:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:46:51 INFO - building 'psutil._psutil_posix' extension 01:46:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:46:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:46:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:46:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:46:51 INFO - Successfully installed psutil 01:46:51 INFO - Cleaning up... 01:46:51 INFO - Return code: 0 01:46:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:51 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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:46:51 INFO - Using env: {'DISPLAY': ':0', 01:46:51 INFO - 'HOME': '/home/cltbld', 01:46:51 INFO - 'LANG': 'en_US.UTF-8', 01:46:51 INFO - 'LANGUAGE': 'en_US:en', 01:46:51 INFO - 'LOGNAME': 'cltbld', 01:46:51 INFO - 'MAIL': '/var/mail/cltbld', 01:46:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:51 INFO - 'MOZ_NO_REMOTE': '1', 01:46:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:51 INFO - 'NO_EM_RESTART': '1', 01:46:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:51 INFO - 'PWD': '/builds/slave/test', 01:46:51 INFO - 'SHELL': '/bin/bash', 01:46:51 INFO - 'SHLVL': '1', 01:46:51 INFO - 'TERM': 'linux', 01:46:51 INFO - 'TMOUT': '86400', 01:46:51 INFO - 'USER': 'cltbld', 01:46:51 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:46:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:51 INFO - '_': '/tools/buildbot/bin/python'} 01:46:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:53 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:46:53 INFO - Installing collected packages: mozsystemmonitor 01:46:53 INFO - Running setup.py install for mozsystemmonitor 01:46:53 INFO - Successfully installed mozsystemmonitor 01:46:53 INFO - Cleaning up... 01:46:53 INFO - Return code: 0 01:46:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:53 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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:46:53 INFO - Using env: {'DISPLAY': ':0', 01:46:53 INFO - 'HOME': '/home/cltbld', 01:46:53 INFO - 'LANG': 'en_US.UTF-8', 01:46:53 INFO - 'LANGUAGE': 'en_US:en', 01:46:53 INFO - 'LOGNAME': 'cltbld', 01:46:53 INFO - 'MAIL': '/var/mail/cltbld', 01:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:53 INFO - 'MOZ_NO_REMOTE': '1', 01:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:53 INFO - 'NO_EM_RESTART': '1', 01:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:53 INFO - 'PWD': '/builds/slave/test', 01:46:53 INFO - 'SHELL': '/bin/bash', 01:46:53 INFO - 'SHLVL': '1', 01:46:53 INFO - 'TERM': 'linux', 01:46:53 INFO - 'TMOUT': '86400', 01:46:53 INFO - 'USER': 'cltbld', 01:46:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:53 INFO - '_': '/tools/buildbot/bin/python'} 01:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:53 INFO - Downloading/unpacking jsonschema==2.5.1 01:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:46:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:55 INFO - Downloading functools32-3.2.3-2.tar.gz 01:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:46:55 INFO - warning: no files found matching '*.txt' 01:46:55 INFO - no previously-included directories found matching 'build' 01:46:55 INFO - no previously-included directories found matching 'dist' 01:46:55 INFO - no previously-included directories found matching '.git*' 01:46:56 INFO - Installing collected packages: jsonschema, functools32 01:46:56 INFO - Running setup.py install for functools32 01:46:56 INFO - warning: no files found matching '*.txt' 01:46:56 INFO - no previously-included directories found matching 'build' 01:46:56 INFO - no previously-included directories found matching 'dist' 01:46:56 INFO - no previously-included directories found matching '.git*' 01:46:56 INFO - Successfully installed jsonschema functools32 01:46:56 INFO - Cleaning up... 01:46:56 INFO - Return code: 0 01:46:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:46:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:46:56 INFO - Using env: {'DISPLAY': ':0', 01:46:56 INFO - 'HOME': '/home/cltbld', 01:46:56 INFO - 'LANG': 'en_US.UTF-8', 01:46:56 INFO - 'LANGUAGE': 'en_US:en', 01:46:56 INFO - 'LOGNAME': 'cltbld', 01:46:56 INFO - 'MAIL': '/var/mail/cltbld', 01:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:56 INFO - 'MOZ_NO_REMOTE': '1', 01:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:56 INFO - 'NO_EM_RESTART': '1', 01:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:56 INFO - 'PWD': '/builds/slave/test', 01:46:56 INFO - 'SHELL': '/bin/bash', 01:46:56 INFO - 'SHLVL': '1', 01:46:56 INFO - 'TERM': 'linux', 01:46:56 INFO - 'TMOUT': '86400', 01:46:56 INFO - 'USER': 'cltbld', 01:46:56 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:56 INFO - '_': '/tools/buildbot/bin/python'} 01:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:56 INFO - Downloading/unpacking blobuploader==1.2.4 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46: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 01:46:58 INFO - Downloading blobuploader-1.2.4.tar.gz 01:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:46:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:46:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:46:58 INFO - Downloading docopt-0.6.1.tar.gz 01:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:46:59 INFO - Installing collected packages: blobuploader, requests, docopt 01:46:59 INFO - Running setup.py install for blobuploader 01:46:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:46:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:46:59 INFO - Running setup.py install for requests 01:46:59 INFO - Running setup.py install for docopt 01:46:59 INFO - Successfully installed blobuploader requests docopt 01:46:59 INFO - Cleaning up... 01:46:59 INFO - Return code: 0 01:46:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:46:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:46:59 INFO - Using env: {'DISPLAY': ':0', 01:46:59 INFO - 'HOME': '/home/cltbld', 01:46:59 INFO - 'LANG': 'en_US.UTF-8', 01:46:59 INFO - 'LANGUAGE': 'en_US:en', 01:46:59 INFO - 'LOGNAME': 'cltbld', 01:46:59 INFO - 'MAIL': '/var/mail/cltbld', 01:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:46:59 INFO - 'MOZ_NO_REMOTE': '1', 01:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:46:59 INFO - 'NO_EM_RESTART': '1', 01:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:46:59 INFO - 'PWD': '/builds/slave/test', 01:46:59 INFO - 'SHELL': '/bin/bash', 01:46:59 INFO - 'SHLVL': '1', 01:46:59 INFO - 'TERM': 'linux', 01:46:59 INFO - 'TMOUT': '86400', 01:46:59 INFO - 'USER': 'cltbld', 01:46:59 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:46:59 INFO - '_': '/tools/buildbot/bin/python'} 01:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:46:59 INFO - Running setup.py (path:/tmp/pip-HMgc3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:46:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:46:59 INFO - Running setup.py (path:/tmp/pip-CN5aLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:00 INFO - Running setup.py (path:/tmp/pip-EW3kfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:00 INFO - Running setup.py (path:/tmp/pip-Elttx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:00 INFO - Running setup.py (path:/tmp/pip-HIySbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:00 INFO - Running setup.py (path:/tmp/pip-PqV0hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:00 INFO - Running setup.py (path:/tmp/pip-Tj04bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:00 INFO - Running setup.py (path:/tmp/pip-piHo6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:00 INFO - Running setup.py (path:/tmp/pip-WddrqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:00 INFO - Running setup.py (path:/tmp/pip-nrDMDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:00 INFO - Running setup.py (path:/tmp/pip-29ycWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:00 INFO - Running setup.py (path:/tmp/pip-E8WHuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:00 INFO - Running setup.py (path:/tmp/pip-UeleDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:00 INFO - Running setup.py (path:/tmp/pip-jCHbCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:00 INFO - Running setup.py (path:/tmp/pip-PTw3Bl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:00 INFO - Running setup.py (path:/tmp/pip-ZV5jZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:01 INFO - Running setup.py (path:/tmp/pip-j5c3HF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:47:01 INFO - Running setup.py install for manifestparser 01:47:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozcrash 01:47:01 INFO - Running setup.py install for mozdebug 01:47:01 INFO - Running setup.py install for mozdevice 01:47:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozfile 01:47:01 INFO - Running setup.py install for mozhttpd 01:47:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozinfo 01:47:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozInstall 01:47:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:47:01 INFO - Running setup.py install for mozleak 01:47:01 INFO - Running setup.py install for mozlog 01:47:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for moznetwork 01:47:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozprocess 01:47:02 INFO - Running setup.py install for mozprofile 01:47:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozrunner 01:47:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Running setup.py install for mozscreenshot 01:47:02 INFO - Running setup.py install for moztest 01:47:02 INFO - Running setup.py install for mozversion 01:47:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:47:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:47:02 INFO - Cleaning up... 01:47:02 INFO - Return code: 0 01:47:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:47:02 INFO - Using env: {'DISPLAY': ':0', 01:47:02 INFO - 'HOME': '/home/cltbld', 01:47:02 INFO - 'LANG': 'en_US.UTF-8', 01:47:02 INFO - 'LANGUAGE': 'en_US:en', 01:47:02 INFO - 'LOGNAME': 'cltbld', 01:47:02 INFO - 'MAIL': '/var/mail/cltbld', 01:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:02 INFO - 'MOZ_NO_REMOTE': '1', 01:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:02 INFO - 'NO_EM_RESTART': '1', 01:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:02 INFO - 'PWD': '/builds/slave/test', 01:47:02 INFO - 'SHELL': '/bin/bash', 01:47:02 INFO - 'SHLVL': '1', 01:47:02 INFO - 'TERM': 'linux', 01:47:02 INFO - 'TMOUT': '86400', 01:47:02 INFO - 'USER': 'cltbld', 01:47:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:02 INFO - '_': '/tools/buildbot/bin/python'} 01:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:47:03 INFO - Running setup.py (path:/tmp/pip-KGEyPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:47:03 INFO - Running setup.py (path:/tmp/pip-8i8aPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:47:03 INFO - Running setup.py (path:/tmp/pip-pNEoQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:47:03 INFO - Running setup.py (path:/tmp/pip-vZvEff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:47:03 INFO - Running setup.py (path:/tmp/pip-PgR1eq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:47:03 INFO - Running setup.py (path:/tmp/pip-czFJLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:47:03 INFO - Running setup.py (path:/tmp/pip-TWLL0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:47:03 INFO - Running setup.py (path:/tmp/pip-5PX5pB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:47:03 INFO - Running setup.py (path:/tmp/pip-ndLzJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:47:03 INFO - Running setup.py (path:/tmp/pip-FAJKl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:47:03 INFO - Running setup.py (path:/tmp/pip-aGYJIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:47:03 INFO - Running setup.py (path:/tmp/pip-WGDytU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:47:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:47:03 INFO - Running setup.py (path:/tmp/pip-iGfIjD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:47:04 INFO - Running setup.py (path:/tmp/pip-oTZqXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:04 INFO - Running setup.py (path:/tmp/pip-cQ6jUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:47:04 INFO - Running setup.py (path:/tmp/pip-l8J4Ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:47:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:47:04 INFO - Running setup.py (path:/tmp/pip-q8EPxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:47:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:06 INFO - Downloading blessings-1.6.tar.gz 01:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:47:06 INFO - Installing collected packages: blessings 01:47:06 INFO - Running setup.py install for blessings 01:47:06 INFO - Successfully installed blessings 01:47:06 INFO - Cleaning up... 01:47:06 INFO - Return code: 0 01:47:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:47:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:06 INFO - Reading from file tmpfile_stdout 01:47:06 INFO - Current package versions: 01:47:06 INFO - argparse == 1.2.1 01:47:06 INFO - blessings == 1.6 01:47:06 INFO - blobuploader == 1.2.4 01:47:06 INFO - docopt == 0.6.1 01:47:06 INFO - functools32 == 3.2.3-2 01:47:06 INFO - jsonschema == 2.5.1 01:47:06 INFO - manifestparser == 1.1 01:47:06 INFO - mozInstall == 1.12 01:47:06 INFO - mozcrash == 0.17 01:47:06 INFO - mozdebug == 0.1 01:47:06 INFO - mozdevice == 0.48 01:47:06 INFO - mozfile == 1.2 01:47:06 INFO - mozhttpd == 0.7 01:47:06 INFO - mozinfo == 0.9 01:47:06 INFO - mozleak == 0.1 01:47:06 INFO - mozlog == 3.2 01:47:06 INFO - moznetwork == 0.27 01:47:06 INFO - mozprocess == 0.22 01:47:06 INFO - mozprofile == 0.28 01:47:06 INFO - mozrunner == 6.11 01:47:06 INFO - mozscreenshot == 0.1 01:47:06 INFO - mozsystemmonitor == 0.3 01:47:06 INFO - moztest == 0.7 01:47:06 INFO - mozversion == 1.4 01:47:06 INFO - psutil == 3.1.1 01:47:06 INFO - requests == 1.2.3 01:47:06 INFO - wsgiref == 0.1.2 01:47:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:06 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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:47:06 INFO - Using env: {'DISPLAY': ':0', 01:47:06 INFO - 'HOME': '/home/cltbld', 01:47:06 INFO - 'LANG': 'en_US.UTF-8', 01:47:06 INFO - 'LANGUAGE': 'en_US:en', 01:47:06 INFO - 'LOGNAME': 'cltbld', 01:47:06 INFO - 'MAIL': '/var/mail/cltbld', 01:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:06 INFO - 'MOZ_NO_REMOTE': '1', 01:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:06 INFO - 'NO_EM_RESTART': '1', 01:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:06 INFO - 'PWD': '/builds/slave/test', 01:47:06 INFO - 'SHELL': '/bin/bash', 01:47:06 INFO - 'SHLVL': '1', 01:47:06 INFO - 'TERM': 'linux', 01:47:06 INFO - 'TMOUT': '86400', 01:47:06 INFO - 'USER': 'cltbld', 01:47:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:06 INFO - '_': '/tools/buildbot/bin/python'} 01:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:47:06 INFO - Cleaning up... 01:47:06 INFO - Return code: 0 01:47:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:47:06 INFO - Using env: {'DISPLAY': ':0', 01:47:06 INFO - 'HOME': '/home/cltbld', 01:47:06 INFO - 'LANG': 'en_US.UTF-8', 01:47:06 INFO - 'LANGUAGE': 'en_US:en', 01:47:06 INFO - 'LOGNAME': 'cltbld', 01:47:06 INFO - 'MAIL': '/var/mail/cltbld', 01:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:06 INFO - 'MOZ_NO_REMOTE': '1', 01:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:06 INFO - 'NO_EM_RESTART': '1', 01:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:06 INFO - 'PWD': '/builds/slave/test', 01:47:06 INFO - 'SHELL': '/bin/bash', 01:47:06 INFO - 'SHLVL': '1', 01:47:06 INFO - 'TERM': 'linux', 01:47:06 INFO - 'TMOUT': '86400', 01:47:06 INFO - 'USER': 'cltbld', 01:47:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:06 INFO - '_': '/tools/buildbot/bin/python'} 01:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:47:07 INFO - Cleaning up... 01:47:07 INFO - Return code: 0 01:47:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:47: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')]} 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47: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')]} 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:47:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:47:07 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 0x7f691632bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26a2020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:47:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:47:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:47:07 INFO - Using env: {'DISPLAY': ':0', 01:47:07 INFO - 'HOME': '/home/cltbld', 01:47:07 INFO - 'LANG': 'en_US.UTF-8', 01:47:07 INFO - 'LANGUAGE': 'en_US:en', 01:47:07 INFO - 'LOGNAME': 'cltbld', 01:47:07 INFO - 'MAIL': '/var/mail/cltbld', 01:47:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:07 INFO - 'MOZ_NO_REMOTE': '1', 01:47:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:07 INFO - 'NO_EM_RESTART': '1', 01:47:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:07 INFO - 'PWD': '/builds/slave/test', 01:47:07 INFO - 'SHELL': '/bin/bash', 01:47:07 INFO - 'SHLVL': '1', 01:47:07 INFO - 'TERM': 'linux', 01:47:07 INFO - 'TMOUT': '86400', 01:47:07 INFO - 'USER': 'cltbld', 01:47:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:47:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:07 INFO - '_': '/tools/buildbot/bin/python'} 01:47:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:47:07 INFO - Downloading/unpacking flake8 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:47:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:47:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:09 INFO - no previously-included directories found matching 'docs/_build' 01:47:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:47:09 INFO - Running setup.py install for pep8 01:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:47:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:47:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:47:10 INFO - no previously-included directories found matching 'docs/_build' 01:47:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:47:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:47:10 INFO - Cleaning up... 01:47:10 INFO - Return code: 0 01:47:10 INFO - Running post-action listener: _resource_record_post_action 01:47:10 INFO - Running post-action listener: _start_resource_monitoring 01:47:10 INFO - Starting resource monitoring. 01:47:10 INFO - ##### 01:47:10 INFO - ##### Finished create-virtualenv step (success) 01:47:10 INFO - ##### 01:47:10 INFO - ##### 01:47:10 INFO - ##### Running install step. 01:47:10 INFO - ##### 01:47:10 INFO - Running pre-action listener: _resource_record_pre_action 01:47:10 INFO - Running main action method: install 01:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:47:10 INFO - Reading from file tmpfile_stdout 01:47:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:47:10 INFO - Reading from file tmpfile_stdout 01:47:10 INFO - Output received: 01:47:10 INFO - Usage: mozinstall [options] installer 01:47:10 INFO - Options: 01:47:10 INFO - -h, --help show this help message and exit 01:47:10 INFO - -d DEST, --destination=DEST 01:47:10 INFO - Directory to install application into. [default: 01:47:10 INFO - "/builds/slave/test"] 01:47:10 INFO - --app=APP Application being installed. [default: firefox] 01:47:10 INFO - mkdir: /builds/slave/test/build/application 01:47:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:47:26 INFO - Reading from file tmpfile_stdout 01:47:26 INFO - Output received: 01:47:26 INFO - /builds/slave/test/build/application/firefox/firefox 01:47:26 INFO - Running post-action listener: _resource_record_post_action 01:47:26 INFO - ##### 01:47:26 INFO - ##### Finished install step (success) 01:47:26 INFO - ##### 01:47:26 INFO - ##### 01:47:26 INFO - ##### Running run-tests step. 01:47:26 INFO - ##### 01:47:26 INFO - Running pre-action listener: _resource_record_pre_action 01:47:26 INFO - Running main action method: run_tests 01:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:47:26 INFO - Python 2.7.3 01:47:26 INFO - Return code: 0 01:47:26 INFO - grabbing minidump binary from tooltool 01:47:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:47:26 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 0x27342e0>, '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 0x26a0140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a05d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:47:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:47:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:47:26 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:47:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:47:26 INFO - Return code: 0 01:47:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:47:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:47:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:47:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:47:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:47:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:47:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:47:27 INFO - Return code: 0 01:47:27 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/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 01:47:27 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/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 01:47:27 INFO - Using env: {'DISPLAY': ':0', 01:47:27 INFO - 'HOME': '/home/cltbld', 01:47:27 INFO - 'LANG': 'en_US.UTF-8', 01:47:27 INFO - 'LANGUAGE': 'en_US:en', 01:47:27 INFO - 'LOGNAME': 'cltbld', 01:47:27 INFO - 'MAIL': '/var/mail/cltbld', 01:47:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:47:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:47:27 INFO - 'MOZ_NO_REMOTE': '1', 01:47:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:47:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:47:27 INFO - 'NO_EM_RESTART': '1', 01:47:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:47:27 INFO - 'PWD': '/builds/slave/test', 01:47:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:47:27 INFO - 'SHELL': '/bin/bash', 01:47:27 INFO - 'SHLVL': '1', 01:47:27 INFO - 'TERM': 'linux', 01:47:27 INFO - 'TMOUT': '86400', 01:47:27 INFO - 'USER': 'cltbld', 01:47:27 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708', 01:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:47:27 INFO - '_': '/tools/buildbot/bin/python'} 01:47:27 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/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 01:47:27 INFO - mozversion application_buildid: 20160621004800 01:47:27 INFO - mozversion application_changeset: be179bb8c58ff829b3c81cbc203833686dd3739e 01:47:27 INFO - mozversion application_display_name: Nightly 01:47:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:47:27 INFO - mozversion application_name: Firefox 01:47:27 INFO - mozversion application_remotingname: firefox 01:47:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:47:27 INFO - mozversion application_vendor: Mozilla 01:47:27 INFO - mozversion application_version: 50.0a1 01:47:27 INFO - mozversion platform_buildid: 20160621004800 01:47:27 INFO - mozversion platform_changeset: be179bb8c58ff829b3c81cbc203833686dd3739e 01:47:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:47:27 INFO - mozversion platform_version: 50.0a1 01:47:27 INFO - using testdate: 1466498847 01:47:27 INFO - actual date: 1466498847 01:47:27 INFO - starting webserver on 'localhost:49204' 01:47:27 INFO - SUITE-START | Running 2 tests 01:47:27 INFO - TEST-START | dromaeo_css 01:47:27 INFO - operating with platform_type : linux_ 01:47:27 INFO - Initialising browser for dromaeo_css test... 01:47:27 INFO - TEST-INFO | started process 4477 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFNVIRV/profile http://localhost:49204/getInfo.html) 01:47:32 INFO - PROCESS | 4477 | __metrics Screen width/height:1600/1200 01:47:32 INFO - PROCESS | 4477 | colorDepth:24 01:47:32 INFO - PROCESS | 4477 | Browser inner width/height: 1024/697 01:47:32 INFO - PROCESS | 4477 | __metrics 01:47:34 INFO - PROCESS | 4477 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:47:34 INFO - TEST-INFO | 4477: exit 0 01:47:34 INFO - Browser initialized. 01:47:34 INFO - Running cycle 1/1 for dromaeo_css test... 01:47:34 INFO - TEST-INFO | started process 4558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFNVIRV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:47:46 INFO - PROCESS | 4558 | RSS: Main: 175693824 01:47:46 INFO - PROCESS | 4558 | 01:48:38 INFO - PROCESS | 4558 | 1466498918083 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:50:51 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49204/tests/dromaeo/cssquery-ext.html) 01:50:52 INFO - PROCESS | 4558 | RSS: Main: 286031872 01:50:52 INFO - PROCESS | 4558 | 01:53:54 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-ext.html (next: http://localhost:49204/tests/dromaeo/cssquery-jquery.html) 01:53:55 INFO - PROCESS | 4558 | RSS: Main: 261791744 01:53:55 INFO - PROCESS | 4558 | 01:56:57 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49204/tests/dromaeo/cssquery-mootools.html) 01:56:58 INFO - PROCESS | 4558 | RSS: Main: 264404992 01:56:58 INFO - PROCESS | 4558 | 02:00:00 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49204/tests/dromaeo/cssquery-prototype.html) 02:00:01 INFO - PROCESS | 4558 | RSS: Main: 256376832 02:00:01 INFO - PROCESS | 4558 | 02:03:04 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49204/tests/dromaeo/cssquery-yui.html) 02:03:04 INFO - PROCESS | 4558 | RSS: Main: 244146176 02:03:04 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | Cycle 1(1): loaded http://localhost:49204/tests/dromaeo/cssquery-yui.html (next: http://localhost:49204/tests/dromaeo/cssquery-dojo.html) 02:06:07 INFO - PROCESS | 4558 | RSS: Main: 301514752 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | __start_tp_report 02:06:07 INFO - PROCESS | 4558 | _x_x_mozilla_page_load 02:06:07 INFO - PROCESS | 4558 | _x_x_mozilla_page_load_details 02:06:07 INFO - PROCESS | 4558 | |i|pagename|runs| 02:06:07 INFO - PROCESS | 4558 | |0;dojo.html;2625.291171383726;2644.8677566121687;2682.3428260076284;2683.2755156107864;2689.5024420482214;4679.532046795319;4770.689905156171;4789.928151077736;4872.074305881884;4912.533309335612;4771.117343291494;4774.7851346689395;4785.641076919228;4813.350197723306;4834.613230941525;4354.956450435503;4424.181526417623;4465.598096171344;4484.9551504485025;4612.838550650711;4489.349044388546;4525.751083690396;4540.046590216059;4550.2264615015365;4575.0392417592175;4360.847370342023;4369.082492676542;4380.496242932072;4406.5593440655675;4411.1618792429335;4361.302191649321;4369.060651959812;4374.759388233646;4463.955360446419;4463.977680111611;4380.189664912002;4401.405810215644;4414.735115893057;4421.403110580062;4458.554144585548;4647.09381670571;4694.741789201593;4711.387519622427;4818.277258411232;4857.6599638025355;5101.6173786965755;5120.359955005624;5199.194124910645;5202.4537423570355;5212.530872221519;5213.113770658997;5233.633645644806;5252.608058864404;5258.605604579672;5259.737013149327;4688.343631891538;4764.285357196379;4815.181419158752;4828.010257897123;4882.7558622068755;5313.920291195635;5350.38470575881;5367.2485851980755;5377.059014672417;5386.757595908193;5098.158803797406;5136.794528218904;5152.793888244429;5157.896842063213;5159.1229490986625;5009.524095210949;5083.5678967288195;5144.536991670768;5157.6647517911215;5238.083335416287;5117.513836185556;5121.4622464641425;5123.359580052494;5128.512791284822;5139.511746384088;5100.69395836251;5110.591152707774;5115.079285728604;5117.616178786531;5165.1219292720325;4308.569143085666;4339.761313127745;4349.999500114928;4398.164348773723;4441.755703436277;3831.003938975831;3866.96133038666;3903.1608204236227;3946.9210615787524;3948.2103579284258;4480.9103817924115;4481.036577135931;4485.641148708096;4491.752953587584;4538.863834084983;5199.532042116228;5240.554552862973;5252.2384254282915;5261.947380526222;5301.628885978022;4328.653707703376;4425.690201685851;4465.441819772528;4484.260097083945;4511.075229577928;4685.929711054337;4702.200625893606;4705.835295764632;4712.835050773275;4720.108059073628;4668.416447944007;4855.878603034882;4874.268859670936;4874.5856602189215;4925.75371231437;5128.4615115413835;5153.974230128825;5197.038547868657;5223.138182200047;5224.634275600672;4805.303231031551;4837.322774811459;4841.419029716457;4846.151923413459;4888;4969.254611808257;5033.119204139188;5078.593712503065;5129.563987061141;5193.896122077613;5147.613928955268;5184.870378240575;5201.609879258995;5215.29593504872;5262.42113367537;5044.848654540369;5053.646244762831;5059.19052951526;5062.063518249136;5118.769655365592;4854.635902307412;4958.355413796184;4988.176950803077;5047.116754568009;5056.873578160576;4944.208926571875;4970.304157417892;4981.252812078217;4992.525710057539;5002.174641184164;5057.342545469212;5064.7467626619255;5067.569256613229;5069.923951140662;5108.029474399852;4840.515948405131;4934.28452874324;4977.850664479926;4987.850364489072;5015.874603134805 02:06:07 INFO - PROCESS | 4558 | |1;ext.html;535.3570455804867;580.3297191743536;593.6408472873914;594.1711312718757;596.7255062671171;26916.73083269167;40344.798276008616;40927.79536102323;40960.59039409605;41145.382819257735;41882.37176442356;42310;42424.36363454543;42467.57532424675;42488.57511424885;7866.921330786676;8008.27925486706;8011;8014.959925200365;8021.839563208732;7918.722844700436;7994.800129996767;7997.480163789364;8017.478863873858;8021.438499305051;8033.397495187855;8085.070216925041;8086.555239461827;8088.676452941875;8090.757277281691;7987.440879138463;8015.639296231683;8028.11690714021;8033.718819841278;8040.35677145827;7959.0449146102255;8024.398170137205;8028.718994835152;8031.317338026275;8037.115917249098;39277.60722392797;39732.40401393981;39735.20529589421;39768.801155994326;39834.40248396277;2813.338865366637;3145.5596216529702;3166.857491412869;3299.2741596848896;3343.097363711784;28926.855365723248;29005.12984610465;29224.853875730485;29349.559756603667;30238.395232095456;3305.5372247885316;3444.844981975817;3476.66971637694;3478.4956181353564;3514.3674138655033;249609;251227.74386128134;252109;252189;253772;54495;55267;55324.72337638286;55325.446745532834;55351.509182086906;33388.49917251195;34485.310293793984;34520.309593807986;34881.82559087239;34897.65102348995;13953.930230348784;14170.00809943294;14231.857681423053;14234.14595124296;14240.715185696436;10636.787264254826;10716.249862509705;10722.946385268024;10723.463826808784;10780;18090;18147.005744052083;18149.818501815076;18212.908935455238;18252.08739563043;6866.725330986705;6889.483288753364;6964.303569642995;7087.610181439967;7257.8911316330295;777.3664463462374;833.3374966901328;895.8566629339274;952.2905435450633;993.4933184076028;27938.301542461195;28197.603203727504;28254;28488.572671409944;28754.71245287562;952.5999080386255;1001.9398836069713;1045.0020230679684;1047.6699839550517;1047.8428235764543;14678;14920.40888472846;15009.774853377208;15115.331079737478;15155.696886062216;377235;379229;380161;380561;380567;49749.25376119361;50173;50366.748166258934;50388.748056260214;50462.74768626207;1056.060106505211;1073.726199819041;1142.7485953090306;1186.4483015397882;1194.2535915053093;27798.44403111967;28719.85640071786;29129.854350728958;29350.559741603465;29624.111276661733;42292;46507;48373.75813120912;48510.5148948506;52269.7386513065;343022;343935;348393;348809;348987.2955716948;33028.33943321168;37066;37242.25515489621;38817.2236555273;39428.40857387084;41649;41988.790056049525;42205.155896882505;42683;42876.142477150905;33941.151471213416;36190.8190459046;36258;36484.45273320849;37092.62907371;34914.127146821535;35990.100247494025;36059.09852253715;36093;36265.27469450649;35515.82242088773;35747.64252357443;35956;36957.81521092377;37474.8126259367;32092.358152837278;33474.66525334813;33518;33964.28071997974;34198.48702269418;25234.74765252324;25287.241382758548;25290.747092529575;25484.745152548236;25778.61332079983 02:06:07 INFO - PROCESS | 4558 | |2;jquery.html;352.1706381471634;354.65952685421996;361.5950135847851;365.53029357275904;382.7741632436862;15581.610459738513;16563.50309490714;17688.38090666827;17691.46925592231;17739.02435366056;16369.263383147758;16634;16670.166491675427;17078.316867325324;17313.48059558212;4921.040397122553;5063.367079115111;5072.26452164436;5105.693658380491;5115.360579927509;3716.869909553166;4997.4003119625695;5637.46444087811;5933.643981361132;5960.79137230197;5981.461668449839;5990.970045149768;6003.8198854034445;6007.669578173199;6019.277686677605;5679.602427830054;5857.092150716646;5875.383084776123;5877.617954832922;5890.381509941437;3356.7482438817187;4859.73271470069;5140.383154021504;5162.561182299509;5165.9225111623355;19559.511012224808;20178;20222;20378.082986265654;20427.285045023353;1819.1540933466001;1925.5956249187548;1932.594155227404;2145.6137895178863;2241.7197850268717;13151.60545183646;13183.53857614979;13302.866971330259;13326.800097998537;13664.385102670403;1693.102655592538;1746.6244757377224;1746.8777185597014;1769.796473405562;1832.8636245527857;59835.40164598342;62506;62774.37225627731;63551.04673429948;64266.357336426976;9203;9314.159181449588;9472.810543789223;9686.176674982564;9791.657291994747;13066.673333166747;13160.934195329153;13186.802197967038;13206.933965330303;13223.73552528944;7080.398166155935;7104.502684812117;7299.635018249066;7356.742514011984;7395;6869.862602747917;6903.896441553381;6920.238773734885;7045.577265364094;7050.823729406806;5892.7642894283745;6075.33171351151;6093.9390606093375;6119.816405507842;6128.724207410677;1526.3589292497177;1640.983590164107;1725.3616162019882;1736.2273788164146;1744.354588802126;832.5421018439833;832.6253186066174;891.5497673674882;928.2295694573488;930.6137952749533;16360.918195408947;16866.409675661293;17055.914720426317;17266.827331726523;17391.652166956843;852.7569642651814;862.779991102265;863.0937515608712;865.3293697384452;900.8423525882944;9618.615255389846;10052.346597471142;10091.798164036678;10169.186465082923;10288;352415;354741;356290;379652;380251.3518627331;42388.57611423908;64487.355126449074;66622.66688666526;67092.66453667701;67497.66251168713;879.564615515324;890.425675439338;901.5221932375852;910.4946754551155;917;14998.325075371416;15000.474983375529;15308;15358.692826143191;15500.612484687523;32406.513902291957;33314;33588.3282334347;34245.31509369848;34298;42349.78825105855;43749.12501750011;43935.12129757323;44015.11969760523;44340.33489497595;7572.39420846342;7667.233276672288;7694.692212311445;7814.140444551209;7891.329237014688;11029.338239705643;11576.884231157917;11763.647090586954;11999.520019199133;12432.627021189379;10259.435731034566;10547.156227501935;10549.314294570828;10578.89421105779;10913.236073475098;9953.751156221153;10654.89345106539;10771.946140269562;10816.945915270373;10892.945535272589;9794.706158815246;10593.947030264799;10647.201459890384;10797.676069717922;10911.672649820519;7588.430867684835;7710.884336734841;7786.61066946639;7797.103333116537;7868.134505204537;9893.65372211969;10414.947925260325;10471.68584942453;10497.055265026183;10582.417967011888 02:06:07 INFO - PROCESS | 4558 | |3;mootools.html;1178.4343515112746;1184.9111316651254;1185.146694380046;1288.916220445671;1535.4625880941678;6558.704858281377;7316.268373162688;7529.698812047518;7539.547627142375;7748.418868584865;7526.397888168947;7677.884831727514;7691.884621730665;7694.499857509258;7707.576083315415;1820.763300770898;2082.9168832207242;2135.306025541697;2153.6338822400153;2177.7168968034134;2148.387709502792;2167.9132834686593;2169.902354394056;2173.065581799833;2177.9019944102474;2145.946351341221;2149.398168512811;2150.2689085710854;2150.709654196687;2176.880271585062;1763.612005358819;2022.9696554551695;2073.792620737929;2105.8631188972668;2111.9366419007456;2057.2902348689677;2074.346580827035;2075.3151460018157;2077.366403247024;2077.7610574783944;7655.464117511777;7693.461457697963;7693.9615301923695;7699.615019249071;7714.961425192894;4405.471343438808;4553.704009239389;4553.863384098482;4566.611837993774;4567.771611419449;2663.893444262227;2829.264391258267;2871.913842584726;2875.0368626509935;2881.6974217707048;884.4118661090367;900.4957223954607;900.5677274908081;931.487681775021;936.7611259128946;10295.073443390056;10298;10313.381197128121;10329.84505232422;10347.275690701654;4008.4588580541254;4106.609872062149;4162.001119731303;4192.4759405074365;4195.706300558932;8756.649734010569;8808.163224493663;8812.91187088121;8826.249768769598;8826.602802873886;4444.93321602813;4448.288273876229;4467.73193608378;4475.015496590745;4476.239039363316;3354.781939173946;3883.10688541637;4017.2969730297664;4017.2969730297664;4061.3501839705505;3440.913977150591;3444.5177675125;3509.052555809917;3550.0947258449446;3552.591451983055;1123.8201887697928;1141.7088642396136;1143.3997151495364;1149.5804031528598;1155.133649762678;712.0316369737153;788.8658927982257;798.4730078148394;809.3161278719473;809.4738420026912;5110.540051395392;5179.04187725272;5296.1261391870685;5336.306280183551;5362.785488580413;378.8560347068096;854.4318028511095;856.4304737349718;882.3382463152635;921.7050543826045;3617.168051348152;3638.9090272742865;3727.235916637137;3754.718396120302;3803;9023.548822558845;9278.860817087749;9389.76525586852;9407.977284883646;9410.717678469657;9257.861132083024;9279.304052196112;9281.443113413081;9294.488803115759;9297.070292970784;7081.575105493687;7085.433165346657;7194.064771579766;7201.747938822116;7203.459740519377;5222.399424066281;5269.604779641466;5329.413764485981;5351.010063138332;5353.652012619323;8427.662893484192;8552.401331906707;8632.741017769476;8643.135686431306;8701.303895688456;8713.477191368538;8888.111188881061;8889.19997200255;8920.330975177018;8941.910580894368;5683.573731970201;6297.937020629735;6417.7753778617525;6933.306669333027;7209.603471808891;7263.782086537412;7436.144843343085;7491.3632341251605;7511.887321690069;7512.436567257587;6378.74485020594;6573.342665733579;6631.171103612049;6677.131972843499;6700.664966751546;6534.967325163344;6548.377904099103;6596.505262105457;6623.370779775913;6642.933570664425;5939.4951429129005;5990.341062483036;5999.49004334619;6000.759969601167;6010.2186715726675;4401.559844015573;4509.481409637933;4567.862964111082;4613.284940834176;4619.653525985497;4528.660350473661;4534.410526631649;4558;4575.107853968444;4650.37219975299 02:06:07 INFO - PROCESS | 4558 | |4;prototype.html;292.05665699789677;293.995590066149;300.1490773656682;300.59269689570647;301.5657453267294;4908.361912951315;4908.7300198489065;4925.729084900329;4925.802967881281;4960.379952505937;4840.709557426548;4850.054239423313;4854.4174699036075;4860.562549370556;4885.804567817292;3860.613938606138;3863.2466668999555;3867.2265546890735;3867.439221312908;3871.8771556248653;3594.5506811648543;3666.651668091527;3867.5358956925206;3868.845246190149;3892.552356479013;3203.471427214507;3655.5065066215984;3676.6690997810324;3679.319325924699;3754.887353379403;3708.332500149972;3773.37739273021;3778.754380965256;3787.5833658297565;3794.4498047783195;3302.091924720721;3309.5366648669205;3310.519974603693;3314.453115235983;3332.166958260435;4444.755538445384;4555.7016250368815;4696.624270058387;4705.882352941169;4730.858074257743;4254.978725106385;4284.957150428487;4295.4201182840225;4298.548652391485;4299.355096735483;5015.3730783652045;5032.949670503322;5034.949650503485;5055.292259083732;5065.214891691794;3540.504329393861;3648.2521083177885;3650.1604630934767;3657.4330978698345;3658.487811706363;5240.371155461331;5240.659357141773;5260.500252476008;5265.605079619006;5275.657082289639;3692.649198326155;3695.5565332159777;3697.315996540595;3719.628037196313;3724.1992971511254;3624.7164286499337;3775.9238616994026;3790.829412676381;3795.8291876865605;3823.489721560024;4245.448091748115;4252.596003379674;4254.7021708480725;4256;4270.615644592001;4997.500249975046;5004.449510553836;5030.924536131961;5058.570021548136;5069.898602027939;1278.7634287656813;1287.5557932513268;1294.8251985981772;1295.436485128972;1295.5659853949032;831.8419500294924;870.4081224767219;871.0984131423946;875.4222213339166;882.0782282514659;4389.563792095418;4434.246178149722;4446.399736035659;4472.463304403427;4492.9775351123035;5092.911906118474;5156.690598564098;5172.8704133999145;5179.585633149339;5195.948040519546;4310.913781724348;4464.464264288241;4481.619062379669;4495.865124046284;4504.369388285642;2737.219892330676;2737.2335745991154;2746.5605503119405;2755.8897644094013;2768.9307767305577;4684.032706263378;4728.4562275338085;4840.515948405131;4845.878853028703;4900.656954013256;5315.813946511854;5327.440618735054;5327.760250788646;5336.62643614951;5337.532178650902;4886.7067975920845;4889.706617602884;4902.90194196114;4909.361782968192;4909.656324057281;4960.156773348467;5183.3261675981885;5190.55880250183;5199.506046925536;5219.217117432416;5028.59771218309;5066.4680208577565;5080.288759573737;5083.389993200692;5093.71984540839;4796.400449943757;4847.297141914332;4850.951490485191;4871.48849370811;4878.341423907727;3439.8796042138406;3636.2000359920776;3685.926281474302;3687.649673281034;3691.427828686558;5146.76839542229;5163.845084647466;5171.637985341141;5175.767090480862;5177.378714554277;5004.324416203766;5016.899662006813;5029.547340739351;5036.622253331088;5049.914268432305;4814.566688998007;5010.348654674869;5020.824271150492;5038.420581633159;5058.595312375075;4931.778069986787;4967.3542439482635;4968;4970.701757894538;4974.403071631427;5006.599472042155;5008.899822003613;5026.220935754964;5070.416902056163;5073.3911930568565;4779.737114458738;4926;5049.772760225872;5061.139606267017;5072.67027643202 02:06:07 INFO - PROCESS | 4558 | |5;yui.html;640.3788325324437;660.3117863171481;713.3829237709383;725.1999522502091;737.3769165055528;12686.429110690018;12794.68013299668;13010.544630937908;13125.081244312902;13667.658308542279;12817.230966142039;12961.35193240339;12987.545435909746;13012.479500819956;13020.023498237622;638.5785381648113;764.4686942574913;772.6098320348231;787.7321710618388;798.9241022102891;785.6189747972229;788.5268838696765;789.7117552093501;790.782534802928;791.2759824760337;833.72487079264;834.2158371131118;834.7203686764941;834.7370578267826;835.2274146414572;658.5390226841206;805.1948051948052;818.6888982186731;821.3100995164091;828.0394742099166;604.619089973314;604.9092636104575;605.3220393159645;605.8606520500309;605.9060845568944;13228.206307621573;13288.933555332258;13292.069555131146;13296.601101966957;13307.733845323137;10750.623728169476;10931.945340273327;11070.723231919266;11105.222634415593;11216.663500094928;10143.289969702124;10168.745781355452;10188.541515631814;10248.12890904274;10255;3966.920661586781;3976.9005774855573;4049.6962727795535;4090.836366545335;4111.71218014739;55135.72432137813;55143.448565514234;55379.44620553783;55389.12276140672;55411.72294138504;9252.026437211622;9446;9511.191548718298;9713.320067595341;9836.803263934682;17018.48944531666;17028.829711702725;17062.061586612854;17184.226709798088;17209.7418538722;6473.385028422293;6524.9673751630935;6527.738890444424;6616.073749675049;6745.8650826983185;3672.485851980725;3690.8339124738914;3707.647773461517;3729.5151630288433;3782.3002744492355;2759.751622353998;2844.9146525604265;2863.9713602863703;2871.4687782760257;2878.0358579875556;393.732262061795;474.1749356120326;474.2270099737406;484.4211167654689;486.0837321648718;521.2363886905702;526.6550409481796;543.1987817968544;557.2671936403616;559.8124628249501;7692.307692307607;7856.607169641495;7927.722529711547;8288.958555207306;8378.455400399076;449.4696258415036;486.34586481182754;503.74560846772147;519.7687029271938;528.7673423693562;3818.6754125899056;3867.45855580219;3870.53553573573;3874.341361968472;3983.2630963271886;55465.722671386386;56965.43034569601;88304.5584772072;90368;90879.54560227157;43455.34816977748;44109;44816.3277550837;45521.772391137834;45523;63716.36283637197;66675.66662166755;67809.66095169492;68647;68871.65564172147;7781.922180778346;7858.960705196438;8127.2279133482225;8158.592070396575;8329.416940814084;40020.59979400169;41539.37690934578;41657.37513937354;42095.57904420917;42173.156536869705;55869;58337.70831145987;59052.704736476044;59433.40566594452;61181.38818611757;8824.11758824138;10202.540885660015;10217.795644086927;10274.280800344202;10934.726631834268;12027.579034733742;12529.49882004746;13127.671808204872;13505.324733763076;13843.377048033064;8814.2948564116;11951.76096478083;11967.341796201292;12112.576059837864;12316.630501084981;12121.75756484883;12339.75320493603;12510.87489125097;12607.306598137191;12649.114561980574;11673.649790506299;11965.521379144737;12198.390080495763;12450.813237801622;12480.687982800502;9527.428354298487;9625.540564777939;9711.417314961125;9800.509974501389;9933.3543319684;9611.231101512001;9758.951205243928;9759.9024009759;10000.099991000845;10053.19574434029 02:06:07 INFO - PROCESS | 4558 | __end_tp_report 02:06:07 INFO - PROCESS | 4558 | __start_cc_report 02:06:07 INFO - PROCESS | 4558 | _x_x_mozilla_cycle_collect,971 02:06:07 INFO - PROCESS | 4558 | __end_cc_report 02:06:07 INFO - PROCESS | 4558 | __startTimestamp1466499967502__endTimestamp 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | ------- Summary: start ------- 02:06:07 INFO - PROCESS | 4558 | Number of tests: 6 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | [#0] dojo.html Cycles:165 Average:4777.90 Median:4874.59 stddev:506.40 (10.4%) stddev-sans-first:478.97 02:06:07 INFO - PROCESS | 4558 | Values: 2625.3 2644.9 2682.3 2683.3 2689.5 4679.5 4770.7 4789.9 4872.1 4912.5 4771.1 4774.8 4785.6 4813.4 4834.6 4355.0 4424.2 4465.6 4485.0 4612.8 4489.3 4525.8 4540.0 4550.2 4575.0 4360.8 4369.1 4380.5 4406.6 4411.2 4361.3 4369.1 4374.8 4464.0 4464.0 4380.2 4401.4 4414.7 4421.4 4458.6 4647.1 4694.7 4711.4 4818.3 4857.7 5101.6 5120.4 5199.2 5202.5 5212.5 5213.1 5233.6 5252.6 5258.6 5259.7 4688.3 4764.3 4815.2 4828.0 4882.8 5313.9 5350.4 5367.2 5377.1 5386.8 5098.2 5136.8 5152.8 5157.9 5159.1 5009.5 5083.6 5144.5 5157.7 5238.1 5117.5 5121.5 5123.4 5128.5 5139.5 5100.7 5110.6 5115.1 5117.6 5165.1 4308.6 4339.8 4350.0 4398.2 4441.8 3831.0 3867.0 3903.2 3946.9 3948.2 4480.9 4481.0 4485.6 4491.8 4538.9 5199.5 5240.6 5252.2 5261.9 5301.6 4328.7 4425.7 4465.4 4484.3 4511.1 4685.9 4702.2 4705.8 4712.8 4720.1 4668.4 4855.9 4874.3 4874.6 4925.8 5128.5 5154.0 5197.0 5223.1 5224.6 4805.3 4837.3 4841.4 4846.2 4888.0 4969.3 5033.1 5078.6 5129.6 5193.9 5147.6 5184.9 5201.6 5215.3 5262.4 5044.8 5053.6 5059.2 5062.1 5118.8 4854.6 4958.4 4988.2 5047.1 5056.9 4944.2 4970.3 4981.3 4992.5 5002.2 5057.3 5064.7 5067.6 5069.9 5108.0 4840.5 4934.3 4977.9 4987.9 5015.9 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | [#1] ext.html Cycles:180 Average:48161.35 Median:36261.64 stddev:86938.73 (239.8%) stddev-sans-first:87109.08 02:06:07 INFO - PROCESS | 4558 | Values: 535.4 580.3 593.6 594.2 596.7 26916.7 40344.8 40927.8 40960.6 41145.4 41882.4 42310.0 42424.4 42467.6 42488.6 7866.9 8008.3 8011.0 8015.0 8021.8 7918.7 7994.8 7997.5 8017.5 8021.4 8033.4 8085.1 8086.6 8088.7 8090.8 7987.4 8015.6 8028.1 8033.7 8040.4 7959.0 8024.4 8028.7 8031.3 8037.1 39277.6 39732.4 39735.2 39768.8 39834.4 2813.3 3145.6 3166.9 3299.3 3343.1 28926.9 29005.1 29224.9 29349.6 30238.4 3305.5 3444.8 3476.7 3478.5 3514.4 249609.0 251227.7 252109.0 252189.0 253772.0 54495.0 55267.0 55324.7 55325.4 55351.5 33388.5 34485.3 34520.3 34881.8 34897.7 13953.9 14170.0 14231.9 14234.1 14240.7 10636.8 10716.2 10722.9 10723.5 10780.0 18090.0 18147.0 18149.8 18212.9 18252.1 6866.7 6889.5 6964.3 7087.6 7257.9 777.4 833.3 895.9 952.3 993.5 27938.3 28197.6 28254.0 28488.6 28754.7 952.6 1001.9 1045.0 1047.7 1047.8 14678.0 14920.4 15009.8 15115.3 15155.7 377235.0 379229.0 380161.0 380561.0 380567.0 49749.3 50173.0 50366.7 50388.7 50462.7 1056.1 1073.7 1142.7 1186.4 1194.3 27798.4 28719.9 29129.9 29350.6 29624.1 42292.0 46507.0 48373.8 48510.5 52269.7 343022.0 343935.0 348393.0 348809.0 348987.3 33028.3 37066.0 37242.3 38817.2 39428.4 41649.0 41988.8 42205.2 42683.0 42876.1 33941.2 36190.8 36258.0 36484.5 37092.6 34914.1 35990.1 36059.1 36093.0 36265.3 35515.8 35747.6 35956.0 36957.8 37474.8 32092.4 33474.7 33518.0 33964.3 34198.5 25234.7 25287.2 25290.7 25484.7 25778.6 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | [#2] jquery.html Cycles:180 Average:22870.81 Median:379951.68 stddev:59841.17 (15.7%) stddev-sans-first:59985.16 02:06:07 INFO - PROCESS | 4558 | Values: 352.2 354.7 361.6 365.5 382.8 15581.6 16563.5 17688.4 17691.5 17739.0 16369.3 16634.0 16670.2 17078.3 17313.5 4921.0 5063.4 5072.3 5105.7 5115.4 3716.9 4997.4 5637.5 5933.6 5960.8 5981.5 5991.0 6003.8 6007.7 6019.3 5679.6 5857.1 5875.4 5877.6 5890.4 3356.7 4859.7 5140.4 5162.6 5165.9 19559.5 20178.0 20222.0 20378.1 20427.3 1819.2 1925.6 1932.6 2145.6 2241.7 13151.6 13183.5 13302.9 13326.8 13664.4 1693.1 1746.6 1746.9 1769.8 1832.9 59835.4 62506.0 62774.4 63551.0 64266.4 9203.0 9314.2 9472.8 9686.2 9791.7 13066.7 13160.9 13186.8 13206.9 13223.7 7080.4 7104.5 7299.6 7356.7 7395.0 6869.9 6903.9 6920.2 7045.6 7050.8 5892.8 6075.3 6093.9 6119.8 6128.7 1526.4 1641.0 1725.4 1736.2 1744.4 832.5 832.6 891.5 928.2 930.6 16360.9 16866.4 17055.9 17266.8 17391.7 852.8 862.8 863.1 865.3 900.8 9618.6 10052.3 10091.8 10169.2 10288.0 352415.0 354741.0 356290.0 379652.0 380251.4 42388.6 64487.4 66622.7 67092.7 67497.7 879.6 890.4 901.5 910.5 917.0 14998.3 15000.5 15308.0 15358.7 15500.6 32406.5 33314.0 33588.3 34245.3 34298.0 42349.8 43749.1 43935.1 44015.1 44340.3 7572.4 7667.2 7694.7 7814.1 7891.3 11029.3 11576.9 11763.6 11999.5 12432.6 10259.4 10547.2 10549.3 10578.9 10913.2 9953.8 10654.9 10771.9 10816.9 10892.9 9794.7 10593.9 10647.2 10797.7 10911.7 7588.4 7710.9 7786.6 7797.1 7868.1 9893.7 10414.9 10471.7 10497.1 10582.4 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | [#3] mootools.html Cycles:180 Average:5005.70 Median:5312.77 stddev:2806.12 (52.8%) stddev-sans-first:2799.25 02:06:07 INFO - PROCESS | 4558 | Values: 1178.4 1184.9 1185.1 1288.9 1535.5 6558.7 7316.3 7529.7 7539.5 7748.4 7526.4 7677.9 7691.9 7694.5 7707.6 1820.8 2082.9 2135.3 2153.6 2177.7 2148.4 2167.9 2169.9 2173.1 2177.9 2145.9 2149.4 2150.3 2150.7 2176.9 1763.6 2023.0 2073.8 2105.9 2111.9 2057.3 2074.3 2075.3 2077.4 2077.8 7655.5 7693.5 7694.0 7699.6 7715.0 4405.5 4553.7 4553.9 4566.6 4567.8 2663.9 2829.3 2871.9 2875.0 2881.7 884.4 900.5 900.6 931.5 936.8 10295.1 10298.0 10313.4 10329.8 10347.3 4008.5 4106.6 4162.0 4192.5 4195.7 8756.6 8808.2 8812.9 8826.2 8826.6 4444.9 4448.3 4467.7 4475.0 4476.2 3354.8 3883.1 4017.3 4017.3 4061.4 3440.9 3444.5 3509.1 3550.1 3552.6 1123.8 1141.7 1143.4 1149.6 1155.1 712.0 788.9 798.5 809.3 809.5 5110.5 5179.0 5296.1 5336.3 5362.8 378.9 854.4 856.4 882.3 921.7 3617.2 3638.9 3727.2 3754.7 3803.0 9023.5 9278.9 9389.8 9408.0 9410.7 9257.9 9279.3 9281.4 9294.5 9297.1 7081.6 7085.4 7194.1 7201.7 7203.5 5222.4 5269.6 5329.4 5351.0 5353.7 8427.7 8552.4 8632.7 8643.1 8701.3 8713.5 8888.1 8889.2 8920.3 8941.9 5683.6 6297.9 6417.8 6933.3 7209.6 7263.8 7436.1 7491.4 7511.9 7512.4 6378.7 6573.3 6631.2 6677.1 6700.7 6535.0 6548.4 6596.5 6623.4 6642.9 5939.5 5990.3 5999.5 6000.8 6010.2 4401.6 4509.5 4567.9 4613.3 4619.7 4528.7 4534.4 4558.0 4575.1 4650.4 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | [#4] prototype.html Cycles:180 Average:4190.31 Median:4840.61 stddev:1214.53 (25.1%) stddev-sans-first:1182.16 02:06:07 INFO - PROCESS | 4558 | Values: 292.1 294.0 300.1 300.6 301.6 4908.4 4908.7 4925.7 4925.8 4960.4 4840.7 4850.1 4854.4 4860.6 4885.8 3860.6 3863.2 3867.2 3867.4 3871.9 3594.6 3666.7 3867.5 3868.8 3892.6 3203.5 3655.5 3676.7 3679.3 3754.9 3708.3 3773.4 3778.8 3787.6 3794.4 3302.1 3309.5 3310.5 3314.5 3332.2 4444.8 4555.7 4696.6 4705.9 4730.9 4255.0 4285.0 4295.4 4298.5 4299.4 5015.4 5032.9 5034.9 5055.3 5065.2 3540.5 3648.3 3650.2 3657.4 3658.5 5240.4 5240.7 5260.5 5265.6 5275.7 3692.6 3695.6 3697.3 3719.6 3724.2 3624.7 3775.9 3790.8 3795.8 3823.5 4245.4 4252.6 4254.7 4256.0 4270.6 4997.5 5004.4 5030.9 5058.6 5069.9 1278.8 1287.6 1294.8 1295.4 1295.6 831.8 870.4 871.1 875.4 882.1 4389.6 4434.2 4446.4 4472.5 4493.0 5092.9 5156.7 5172.9 5179.6 5195.9 4310.9 4464.5 4481.6 4495.9 4504.4 2737.2 2737.2 2746.6 2755.9 2768.9 4684.0 4728.5 4840.5 4845.9 4900.7 5315.8 5327.4 5327.8 5336.6 5337.5 4886.7 4889.7 4902.9 4909.4 4909.7 4960.2 5183.3 5190.6 5199.5 5219.2 5028.6 5066.5 5080.3 5083.4 5093.7 4796.4 4847.3 4851.0 4871.5 4878.3 3439.9 3636.2 3685.9 3687.6 3691.4 5146.8 5163.8 5171.6 5175.8 5177.4 5004.3 5016.9 5029.5 5036.6 5049.9 4814.6 5010.3 5020.8 5038.4 5058.6 4931.8 4967.4 4968.0 4970.7 4974.4 5006.6 5008.9 5026.2 5070.4 5073.4 4779.7 4926.0 5049.8 5061.1 5072.7 02:06:07 INFO - PROCESS | 4558 | 02:06:07 INFO - PROCESS | 4558 | [#5] yui.html Cycles:180 Average:15354.11 Median:486.21 stddev:20209.18 (4156.4%) stddev-sans-first:20235.67 02:06:07 INFO - PROCESS | 4558 | Values: 640.4 660.3 713.4 725.2 737.4 12686.4 12794.7 13010.5 13125.1 13667.7 12817.2 12961.4 12987.5 13012.5 13020.0 638.6 764.5 772.6 787.7 798.9 785.6 788.5 789.7 790.8 791.3 833.7 834.2 834.7 834.7 835.2 658.5 805.2 818.7 821.3 828.0 604.6 604.9 605.3 605.9 605.9 13228.2 13288.9 13292.1 13296.6 13307.7 10750.6 10931.9 11070.7 11105.2 11216.7 10143.3 10168.7 10188.5 10248.1 10255.0 3966.9 3976.9 4049.7 4090.8 4111.7 55135.7 55143.4 55379.4 55389.1 55411.7 9252.0 9446.0 9511.2 9713.3 9836.8 17018.5 17028.8 17062.1 17184.2 17209.7 6473.4 6525.0 6527.7 6616.1 6745.9 3672.5 3690.8 3707.6 3729.5 3782.3 2759.8 2844.9 2864.0 2871.5 2878.0 393.7 474.2 474.2 484.4 486.1 521.2 526.7 543.2 557.3 559.8 7692.3 7856.6 7927.7 8289.0 8378.5 449.5 486.3 503.7 519.8 528.8 3818.7 3867.5 3870.5 3874.3 3983.3 55465.7 56965.4 88304.6 90368.0 90879.5 43455.3 44109.0 44816.3 45521.8 45523.0 63716.4 66675.7 67809.7 68647.0 68871.7 7781.9 7859.0 8127.2 8158.6 8329.4 40020.6 41539.4 41657.4 42095.6 42173.2 55869.0 58337.7 59052.7 59433.4 61181.4 8824.1 10202.5 10217.8 10274.3 10934.7 12027.6 12529.5 13127.7 13505.3 13843.4 8814.3 11951.8 11967.3 12112.6 12316.6 12121.8 12339.8 12510.9 12607.3 12649.1 11673.6 11965.5 12198.4 12450.8 12480.7 9527.4 9625.5 9711.4 9800.5 9933.4 9611.2 9759.0 9759.9 10000.1 10053.2 02:06:07 INFO - PROCESS | 4558 | -------- Summary: end -------- 02:06:07 INFO - PROCESS | 4558 | 02:06:08 INFO - TEST-INFO | 4558: exit 0 02:06:08 INFO - TEST-OK | dromaeo_css | took 1120504ms 02:06:08 INFO - TEST-START | kraken 02:06:08 INFO - operating with platform_type : linux_ 02:06:08 INFO - Initialising browser for kraken test... 02:06:08 INFO - TEST-INFO | started process 4733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FgIlR/profile http://localhost:49204/getInfo.html) 02:06:12 INFO - PROCESS | 4733 | __metrics Screen width/height:1600/1200 02:06:12 INFO - PROCESS | 4733 | colorDepth:24 02:06:12 INFO - PROCESS | 4733 | Browser inner width/height: 1024/697 02:06:12 INFO - PROCESS | 4733 | __metrics 02:06:13 INFO - PROCESS | 4733 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:06:15 INFO - TEST-INFO | 4733: exit 0 02:06:15 INFO - Browser initialized. 02:06:15 INFO - Running cycle 1/1 for kraken test... 02:06:15 INFO - TEST-INFO | started process 4812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3FgIlR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:27 INFO - PROCESS | 4812 | RSS: Main: 176087040 02:06:27 INFO - PROCESS | 4812 | 02:06:29 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-beat-detection) 02:06:30 INFO - PROCESS | 4812 | RSS: Main: 234577920 02:06:30 INFO - PROCESS | 4812 | 02:06:33 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-dft) 02:06:34 INFO - PROCESS | 4812 | RSS: Main: 221630464 02:06:34 INFO - PROCESS | 4812 | 02:06:37 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-fft) 02:06:38 INFO - PROCESS | 4812 | RSS: Main: 289030144 02:06:38 INFO - PROCESS | 4812 | 02:06:40 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49204/tests/kraken/driver.html?testName=audio-oscillator) 02:06:40 INFO - PROCESS | 4812 | RSS: Main: 199831552 02:06:40 INFO - PROCESS | 4812 | 02:06:43 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49204/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:06:43 INFO - PROCESS | 4812 | RSS: Main: 203374592 02:06:43 INFO - PROCESS | 4812 | 02:06:46 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49204/tests/kraken/driver.html?testName=imaging-darkroom) 02:06:47 INFO - PROCESS | 4812 | RSS: Main: 239128576 02:06:47 INFO - PROCESS | 4812 | 02:06:50 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49204/tests/kraken/driver.html?testName=imaging-desaturate) 02:06:51 INFO - PROCESS | 4812 | RSS: Main: 235020288 02:06:51 INFO - PROCESS | 4812 | 02:06:54 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49204/tests/kraken/driver.html?testName=json-parse-financial) 02:06:55 INFO - PROCESS | 4812 | RSS: Main: 237432832 02:06:55 INFO - PROCESS | 4812 | 02:06:56 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49204/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:06:57 INFO - PROCESS | 4812 | RSS: Main: 226594816 02:06:57 INFO - PROCESS | 4812 | 02:06:59 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:06:59 INFO - PROCESS | 4812 | RSS: Main: 229588992 02:06:59 INFO - PROCESS | 4812 | 02:07:02 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:07:02 INFO - PROCESS | 4812 | RSS: Main: 235532288 02:07:02 INFO - PROCESS | 4812 | 02:07:05 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:07:06 INFO - PROCESS | 4812 | RSS: Main: 240472064 02:07:06 INFO - PROCESS | 4812 | 02:07:09 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:07:09 INFO - PROCESS | 4812 | RSS: Main: 242245632 02:07:09 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | Cycle 1(1): loaded http://localhost:49204/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49204/tests/kraken/driver.html?testName=ai-astar) 02:07:11 INFO - PROCESS | 4812 | RSS: Main: 284930048 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | __start_tp_report 02:07:11 INFO - PROCESS | 4812 | _x_x_mozilla_page_load 02:07:11 INFO - PROCESS | 4812 | _x_x_mozilla_page_load_details 02:07:11 INFO - PROCESS | 4812 | |i|pagename|runs| 02:07:11 INFO - PROCESS | 4812 | |0;ai-astar;114;109;114;114;115;113;113;113;112;112 02:07:11 INFO - PROCESS | 4812 | |1;audio-beat-detection;158;151;134;179;133;130;150;131;205;128 02:07:11 INFO - PROCESS | 4812 | |2;audio-dft;162;162;163;161;161;161;162;161;162;160 02:07:11 INFO - PROCESS | 4812 | |3;audio-fft;75;76;79;120;76;77;78;75;100;75 02:07:11 INFO - PROCESS | 4812 | |4;audio-oscillator;87;86;119;86;87;86;114;86;87;131 02:07:11 INFO - PROCESS | 4812 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;117;117;116 02:07:11 INFO - PROCESS | 4812 | |6;imaging-darkroom;148;148;150;147;147;147;147;146;147;147 02:07:11 INFO - PROCESS | 4812 | |7;imaging-desaturate;95;96;94;95;95;94;95;95;95;95 02:07:11 INFO - PROCESS | 4812 | |8;json-parse-financial;63;64;62;63;65;64;63;63;62;63 02:07:11 INFO - PROCESS | 4812 | |9;json-stringify-tinderbox;64;65;64;65;66;65;65;64;64;65 02:07:11 INFO - PROCESS | 4812 | |10;stanford-crypto-aes;86;83;84;84;86;90;85;88;115;86 02:07:11 INFO - PROCESS | 4812 | |11;stanford-crypto-ccm;142;133;132;127;129;130;129;129;158;133 02:07:11 INFO - PROCESS | 4812 | |12;stanford-crypto-pbkdf2;172;171;170;169;175;175;171;175;169;169 02:07:11 INFO - PROCESS | 4812 | |13;stanford-crypto-sha256-iterative;69;68;71;67;70;67;72;67;67;78 02:07:11 INFO - PROCESS | 4812 | __end_tp_report 02:07:11 INFO - PROCESS | 4812 | __start_cc_report 02:07:11 INFO - PROCESS | 4812 | _x_x_mozilla_cycle_collect,1851 02:07:11 INFO - PROCESS | 4812 | __end_cc_report 02:07:11 INFO - PROCESS | 4812 | __startTimestamp1466500031714__endTimestamp 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | ------- Summary: start ------- 02:07:11 INFO - PROCESS | 4812 | Number of tests: 14 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.50 stddev:1.66 (1.5%) stddev-sans-first:1.72 02:07:11 INFO - PROCESS | 4812 | Values: 114.0 109.0 114.0 114.0 115.0 113.0 113.0 113.0 112.0 112.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:150.50 stddev:25.21 (16.8%) stddev-sans-first:26.57 02:07:11 INFO - PROCESS | 4812 | Values: 158.0 151.0 134.0 179.0 133.0 130.0 150.0 131.0 205.0 128.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 02:07:11 INFO - PROCESS | 4812 | Values: 162.0 162.0 163.0 161.0 161.0 161.0 162.0 161.0 162.0 160.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:15.00 (19.7%) stddev-sans-first:15.62 02:07:11 INFO - PROCESS | 4812 | Values: 75.0 76.0 79.0 120.0 76.0 77.0 78.0 75.0 100.0 75.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:86.00 stddev:17.36 (20.2%) stddev-sans-first:18.04 02:07:11 INFO - PROCESS | 4812 | Values: 87.0 86.0 119.0 86.0 87.0 86.0 114.0 86.0 87.0 131.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.71 (0.6%) stddev-sans-first:0.73 02:07:11 INFO - PROCESS | 4812 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 117.0 117.0 116.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 02:07:11 INFO - PROCESS | 4812 | Values: 148.0 148.0 150.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:07:11 INFO - PROCESS | 4812 | Values: 95.0 96.0 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 02:07:11 INFO - PROCESS | 4812 | Values: 63.0 64.0 62.0 63.0 65.0 64.0 63.0 63.0 62.0 63.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 02:07:11 INFO - PROCESS | 4812 | Values: 64.0 65.0 64.0 65.0 66.0 65.0 65.0 64.0 64.0 65.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:86.00 stddev:9.46 (11.0%) stddev-sans-first:9.99 02:07:11 INFO - PROCESS | 4812 | Values: 86.0 83.0 84.0 84.0 86.0 90.0 85.0 88.0 115.0 86.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.50 stddev:9.34 (7.1%) stddev-sans-first:9.47 02:07:11 INFO - PROCESS | 4812 | Values: 142.0 133.0 132.0 127.0 129.0 130.0 129.0 129.0 158.0 133.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:2.55 (1.5%) stddev-sans-first:2.70 02:07:11 INFO - PROCESS | 4812 | Values: 172.0 171.0 170.0 169.0 175.0 175.0 171.0 175.0 169.0 169.0 02:07:11 INFO - PROCESS | 4812 | 02:07:11 INFO - PROCESS | 4812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:3.47 (5.0%) stddev-sans-first:3.67 02:07:11 INFO - PROCESS | 4812 | Values: 69.0 68.0 71.0 67.0 70.0 67.0 72.0 67.0 67.0 78.0 02:07:11 INFO - PROCESS | 4812 | -------- Summary: end -------- 02:07:11 INFO - PROCESS | 4812 | 02:07:12 INFO - TEST-INFO | 4812: exit 0 02:07:12 INFO - TEST-OK | kraken | took 64486ms 02:07:12 INFO - SUITE-END | took 1184s 02:07:12 INFO - Completed test suite (00:19:45) 02:07:12 INFO - javascript benchmark 02:07:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2625.291171383726, 2644.8677566121687, 2682.3428260076284, 2683.2755156107864, 2689.5024420482214, 4679.532046795319, 4770.689905156171, 4789.928151077736, 4872.074305881884, 4912.533309335612, 4771.117343291494, 4774.7851346689395, 4785.641076919228, 4813.350197723306, 4834.613230941525, 4354.956450435503, 4424.181526417623, 4465.598096171344, 4484.9551504485025, 4612.838550650711, 4489.349044388546, 4525.751083690396, 4540.046590216059, 4550.2264615015365, 4575.0392417592175, 4360.847370342023, 4369.082492676542, 4380.496242932072, 4406.5593440655675, 4411.1618792429335, 4361.302191649321, 4369.060651959812, 4374.759388233646, 4463.955360446419, 4463.977680111611, 4380.189664912002, 4401.405810215644, 4414.735115893057, 4421.403110580062, 4458.554144585548, 4647.09381670571, 4694.741789201593, 4711.387519622427, 4818.277258411232, 4857.6599638025355, 5101.6173786965755, 5120.359955005624, 5199.194124910645, 5202.4537423570355, 5212.530872221519, 5213.113770658997, 5233.633645644806, 5252.608058864404, 5258.605604579672, 5259.737013149327, 4688.343631891538, 4764.285357196379, 4815.181419158752, 4828.010257897123, 4882.7558622068755, 5313.920291195635, 5350.38470575881, 5367.2485851980755, 5377.059014672417, 5386.757595908193, 5098.158803797406, 5136.794528218904, 5152.793888244429, 5157.896842063213, 5159.1229490986625, 5009.524095210949, 5083.5678967288195, 5144.536991670768, 5157.6647517911215, 5238.083335416287, 5117.513836185556, 5121.4622464641425, 5123.359580052494, 5128.512791284822, 5139.511746384088, 5100.69395836251, 5110.591152707774, 5115.079285728604, 5117.616178786531, 5165.1219292720325, 4308.569143085666, 4339.761313127745, 4349.999500114928, 4398.164348773723, 4441.755703436277, 3831.003938975831, 3866.96133038666, 3903.1608204236227, 3946.9210615787524, 3948.2103579284258, 4480.9103817924115, 4481.036577135931, 4485.641148708096, 4491.752953587584, 4538.863834084983, 5199.532042116228, 5240.554552862973, 5252.2384254282915, 5261.947380526222, 5301.628885978022, 4328.653707703376, 4425.690201685851, 4465.441819772528, 4484.260097083945, 4511.075229577928, 4685.929711054337, 4702.200625893606, 4705.835295764632, 4712.835050773275, 4720.108059073628, 4668.416447944007, 4855.878603034882, 4874.268859670936, 4874.5856602189215, 4925.75371231437, 5128.4615115413835, 5153.974230128825, 5197.038547868657, 5223.138182200047, 5224.634275600672, 4805.303231031551, 4837.322774811459, 4841.419029716457, 4846.151923413459, 4888.0, 4969.254611808257, 5033.119204139188, 5078.593712503065, 5129.563987061141, 5193.896122077613, 5147.613928955268, 5184.870378240575, 5201.609879258995, 5215.29593504872, 5262.42113367537, 5044.848654540369, 5053.646244762831, 5059.19052951526, 5062.063518249136, 5118.769655365592, 4854.635902307412, 4958.355413796184, 4988.176950803077, 5047.116754568009, 5056.873578160576, 4944.208926571875, 4970.304157417892, 4981.252812078217, 4992.525710057539, 5002.174641184164, 5057.342545469212, 5064.7467626619255, 5067.569256613229, 5069.923951140662, 5108.029474399852, 4840.515948405131, 4934.28452874324, 4977.850664479926, 4987.850364489072, 5015.874603134805], "value": 4745.117548360765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [535.3570455804867, 580.3297191743536, 593.6408472873914, 594.1711312718757, 596.7255062671171, 26916.73083269167, 40344.798276008616, 40927.79536102323, 40960.59039409605, 41145.382819257735, 41882.37176442356, 42310.0, 42424.36363454543, 42467.57532424675, 42488.57511424885, 7866.921330786676, 8008.27925486706, 8011.0, 8014.959925200365, 8021.839563208732, 7918.722844700436, 7994.800129996767, 7997.480163789364, 8017.478863873858, 8021.438499305051, 8033.397495187855, 8085.070216925041, 8086.555239461827, 8088.676452941875, 8090.757277281691, 7987.440879138463, 8015.639296231683, 8028.11690714021, 8033.718819841278, 8040.35677145827, 7959.0449146102255, 8024.398170137205, 8028.718994835152, 8031.317338026275, 8037.115917249098, 39277.60722392797, 39732.40401393981, 39735.20529589421, 39768.801155994326, 39834.40248396277, 2813.338865366637, 3145.5596216529702, 3166.857491412869, 3299.2741596848896, 3343.097363711784, 28926.855365723248, 29005.12984610465, 29224.853875730485, 29349.559756603667, 30238.395232095456, 3305.5372247885316, 3444.844981975817, 3476.66971637694, 3478.4956181353564, 3514.3674138655033, 249609.0, 251227.74386128134, 252109.0, 252189.0, 253772.0, 54495.0, 55267.0, 55324.72337638286, 55325.446745532834, 55351.509182086906, 33388.49917251195, 34485.310293793984, 34520.309593807986, 34881.82559087239, 34897.65102348995, 13953.930230348784, 14170.00809943294, 14231.857681423053, 14234.14595124296, 14240.715185696436, 10636.787264254826, 10716.249862509705, 10722.946385268024, 10723.463826808784, 10780.0, 18090.0, 18147.005744052083, 18149.818501815076, 18212.908935455238, 18252.08739563043, 6866.725330986705, 6889.483288753364, 6964.303569642995, 7087.610181439967, 7257.8911316330295, 777.3664463462374, 833.3374966901328, 895.8566629339274, 952.2905435450633, 993.4933184076028, 27938.301542461195, 28197.603203727504, 28254.0, 28488.572671409944, 28754.71245287562, 952.5999080386255, 1001.9398836069713, 1045.0020230679684, 1047.6699839550517, 1047.8428235764543, 14678.0, 14920.40888472846, 15009.774853377208, 15115.331079737478, 15155.696886062216, 377235.0, 379229.0, 380161.0, 380561.0, 380567.0, 49749.25376119361, 50173.0, 50366.748166258934, 50388.748056260214, 50462.74768626207, 1056.060106505211, 1073.726199819041, 1142.7485953090306, 1186.4483015397882, 1194.2535915053093, 27798.44403111967, 28719.85640071786, 29129.854350728958, 29350.559741603465, 29624.111276661733, 42292.0, 46507.0, 48373.75813120912, 48510.5148948506, 52269.7386513065, 343022.0, 343935.0, 348393.0, 348809.0, 348987.2955716948, 33028.33943321168, 37066.0, 37242.25515489621, 38817.2236555273, 39428.40857387084, 41649.0, 41988.790056049525, 42205.155896882505, 42683.0, 42876.142477150905, 33941.151471213416, 36190.8190459046, 36258.0, 36484.45273320849, 37092.62907371, 34914.127146821535, 35990.100247494025, 36059.09852253715, 36093.0, 36265.27469450649, 35515.82242088773, 35747.64252357443, 35956.0, 36957.81521092377, 37474.8126259367, 32092.358152837278, 33474.66525334813, 33518.0, 33964.28071997974, 34198.48702269418, 25234.74765252324, 25287.241382758548, 25290.747092529575, 25484.745152548236, 25778.61332079983], "value": 17731.38651945529, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.1706381471634, 354.65952685421996, 361.5950135847851, 365.53029357275904, 382.7741632436862, 15581.610459738513, 16563.50309490714, 17688.38090666827, 17691.46925592231, 17739.02435366056, 16369.263383147758, 16634.0, 16670.166491675427, 17078.316867325324, 17313.48059558212, 4921.040397122553, 5063.367079115111, 5072.26452164436, 5105.693658380491, 5115.360579927509, 3716.869909553166, 4997.4003119625695, 5637.46444087811, 5933.643981361132, 5960.79137230197, 5981.461668449839, 5990.970045149768, 6003.8198854034445, 6007.669578173199, 6019.277686677605, 5679.602427830054, 5857.092150716646, 5875.383084776123, 5877.617954832922, 5890.381509941437, 3356.7482438817187, 4859.73271470069, 5140.383154021504, 5162.561182299509, 5165.9225111623355, 19559.511012224808, 20178.0, 20222.0, 20378.082986265654, 20427.285045023353, 1819.1540933466001, 1925.5956249187548, 1932.594155227404, 2145.6137895178863, 2241.7197850268717, 13151.60545183646, 13183.53857614979, 13302.866971330259, 13326.800097998537, 13664.385102670403, 1693.102655592538, 1746.6244757377224, 1746.8777185597014, 1769.796473405562, 1832.8636245527857, 59835.40164598342, 62506.0, 62774.37225627731, 63551.04673429948, 64266.357336426976, 9203.0, 9314.159181449588, 9472.810543789223, 9686.176674982564, 9791.657291994747, 13066.673333166747, 13160.934195329153, 13186.802197967038, 13206.933965330303, 13223.73552528944, 7080.398166155935, 7104.502684812117, 7299.635018249066, 7356.742514011984, 7395.0, 6869.862602747917, 6903.896441553381, 6920.238773734885, 7045.577265364094, 7050.823729406806, 5892.7642894283745, 6075.33171351151, 6093.9390606093375, 6119.816405507842, 6128.724207410677, 1526.3589292497177, 1640.983590164107, 1725.3616162019882, 1736.2273788164146, 1744.354588802126, 832.5421018439833, 832.6253186066174, 891.5497673674882, 928.2295694573488, 930.6137952749533, 16360.918195408947, 16866.409675661293, 17055.914720426317, 17266.827331726523, 17391.652166956843, 852.7569642651814, 862.779991102265, 863.0937515608712, 865.3293697384452, 900.8423525882944, 9618.615255389846, 10052.346597471142, 10091.798164036678, 10169.186465082923, 10288.0, 352415.0, 354741.0, 356290.0, 379652.0, 380251.3518627331, 42388.57611423908, 64487.355126449074, 66622.66688666526, 67092.66453667701, 67497.66251168713, 879.564615515324, 890.425675439338, 901.5221932375852, 910.4946754551155, 917.0, 14998.325075371416, 15000.474983375529, 15308.0, 15358.692826143191, 15500.612484687523, 32406.513902291957, 33314.0, 33588.3282334347, 34245.31509369848, 34298.0, 42349.78825105855, 43749.12501750011, 43935.12129757323, 44015.11969760523, 44340.33489497595, 7572.39420846342, 7667.233276672288, 7694.692212311445, 7814.140444551209, 7891.329237014688, 11029.338239705643, 11576.884231157917, 11763.647090586954, 11999.520019199133, 12432.627021189379, 10259.435731034566, 10547.156227501935, 10549.314294570828, 10578.89421105779, 10913.236073475098, 9953.751156221153, 10654.89345106539, 10771.946140269562, 10816.945915270373, 10892.945535272589, 9794.706158815246, 10593.947030264799, 10647.201459890384, 10797.676069717922, 10911.672649820519, 7588.430867684835, 7710.884336734841, 7786.61066946639, 7797.103333116537, 7868.134505204537, 9893.65372211969, 10414.947925260325, 10471.68584942453, 10497.055265026183, 10582.417967011888], "value": 8229.53686298603, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1178.4343515112746, 1184.9111316651254, 1185.146694380046, 1288.916220445671, 1535.4625880941678, 6558.704858281377, 7316.268373162688, 7529.698812047518, 7539.547627142375, 7748.418868584865, 7526.397888168947, 7677.884831727514, 7691.884621730665, 7694.499857509258, 7707.576083315415, 1820.763300770898, 2082.9168832207242, 2135.306025541697, 2153.6338822400153, 2177.7168968034134, 2148.387709502792, 2167.9132834686593, 2169.902354394056, 2173.065581799833, 2177.9019944102474, 2145.946351341221, 2149.398168512811, 2150.2689085710854, 2150.709654196687, 2176.880271585062, 1763.612005358819, 2022.9696554551695, 2073.792620737929, 2105.8631188972668, 2111.9366419007456, 2057.2902348689677, 2074.346580827035, 2075.3151460018157, 2077.366403247024, 2077.7610574783944, 7655.464117511777, 7693.461457697963, 7693.9615301923695, 7699.615019249071, 7714.961425192894, 4405.471343438808, 4553.704009239389, 4553.863384098482, 4566.611837993774, 4567.771611419449, 2663.893444262227, 2829.264391258267, 2871.913842584726, 2875.0368626509935, 2881.6974217707048, 884.4118661090367, 900.4957223954607, 900.5677274908081, 931.487681775021, 936.7611259128946, 10295.073443390056, 10298.0, 10313.381197128121, 10329.84505232422, 10347.275690701654, 4008.4588580541254, 4106.609872062149, 4162.001119731303, 4192.4759405074365, 4195.706300558932, 8756.649734010569, 8808.163224493663, 8812.91187088121, 8826.249768769598, 8826.602802873886, 4444.93321602813, 4448.288273876229, 4467.73193608378, 4475.015496590745, 4476.239039363316, 3354.781939173946, 3883.10688541637, 4017.2969730297664, 4017.2969730297664, 4061.3501839705505, 3440.913977150591, 3444.5177675125, 3509.052555809917, 3550.0947258449446, 3552.591451983055, 1123.8201887697928, 1141.7088642396136, 1143.3997151495364, 1149.5804031528598, 1155.133649762678, 712.0316369737153, 788.8658927982257, 798.4730078148394, 809.3161278719473, 809.4738420026912, 5110.540051395392, 5179.04187725272, 5296.1261391870685, 5336.306280183551, 5362.785488580413, 378.8560347068096, 854.4318028511095, 856.4304737349718, 882.3382463152635, 921.7050543826045, 3617.168051348152, 3638.9090272742865, 3727.235916637137, 3754.718396120302, 3803.0, 9023.548822558845, 9278.860817087749, 9389.76525586852, 9407.977284883646, 9410.717678469657, 9257.861132083024, 9279.304052196112, 9281.443113413081, 9294.488803115759, 9297.070292970784, 7081.575105493687, 7085.433165346657, 7194.064771579766, 7201.747938822116, 7203.459740519377, 5222.399424066281, 5269.604779641466, 5329.413764485981, 5351.010063138332, 5353.652012619323, 8427.662893484192, 8552.401331906707, 8632.741017769476, 8643.135686431306, 8701.303895688456, 8713.477191368538, 8888.111188881061, 8889.19997200255, 8920.330975177018, 8941.910580894368, 5683.573731970201, 6297.937020629735, 6417.7753778617525, 6933.306669333027, 7209.603471808891, 7263.782086537412, 7436.144843343085, 7491.3632341251605, 7511.887321690069, 7512.436567257587, 6378.74485020594, 6573.342665733579, 6631.171103612049, 6677.131972843499, 6700.664966751546, 6534.967325163344, 6548.377904099103, 6596.505262105457, 6623.370779775913, 6642.933570664425, 5939.4951429129005, 5990.341062483036, 5999.49004334619, 6000.759969601167, 6010.2186715726675, 4401.559844015573, 4509.481409637933, 4567.862964111082, 4613.284940834176, 4619.653525985497, 4528.660350473661, 4534.410526631649, 4558.0, 4575.107853968444, 4650.37219975299], "value": 4011.715851549674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.05665699789677, 293.995590066149, 300.1490773656682, 300.59269689570647, 301.5657453267294, 4908.361912951315, 4908.7300198489065, 4925.729084900329, 4925.802967881281, 4960.379952505937, 4840.709557426548, 4850.054239423313, 4854.4174699036075, 4860.562549370556, 4885.804567817292, 3860.613938606138, 3863.2466668999555, 3867.2265546890735, 3867.439221312908, 3871.8771556248653, 3594.5506811648543, 3666.651668091527, 3867.5358956925206, 3868.845246190149, 3892.552356479013, 3203.471427214507, 3655.5065066215984, 3676.6690997810324, 3679.319325924699, 3754.887353379403, 3708.332500149972, 3773.37739273021, 3778.754380965256, 3787.5833658297565, 3794.4498047783195, 3302.091924720721, 3309.5366648669205, 3310.519974603693, 3314.453115235983, 3332.166958260435, 4444.755538445384, 4555.7016250368815, 4696.624270058387, 4705.882352941169, 4730.858074257743, 4254.978725106385, 4284.957150428487, 4295.4201182840225, 4298.548652391485, 4299.355096735483, 5015.3730783652045, 5032.949670503322, 5034.949650503485, 5055.292259083732, 5065.214891691794, 3540.504329393861, 3648.2521083177885, 3650.1604630934767, 3657.4330978698345, 3658.487811706363, 5240.371155461331, 5240.659357141773, 5260.500252476008, 5265.605079619006, 5275.657082289639, 3692.649198326155, 3695.5565332159777, 3697.315996540595, 3719.628037196313, 3724.1992971511254, 3624.7164286499337, 3775.9238616994026, 3790.829412676381, 3795.8291876865605, 3823.489721560024, 4245.448091748115, 4252.596003379674, 4254.7021708480725, 4256.0, 4270.615644592001, 4997.500249975046, 5004.449510553836, 5030.924536131961, 5058.570021548136, 5069.898602027939, 1278.7634287656813, 1287.5557932513268, 1294.8251985981772, 1295.436485128972, 1295.5659853949032, 831.8419500294924, 870.4081224767219, 871.0984131423946, 875.4222213339166, 882.0782282514659, 4389.563792095418, 4434.246178149722, 4446.399736035659, 4472.463304403427, 4492.9775351123035, 5092.911906118474, 5156.690598564098, 5172.8704133999145, 5179.585633149339, 5195.948040519546, 4310.913781724348, 4464.464264288241, 4481.619062379669, 4495.865124046284, 4504.369388285642, 2737.219892330676, 2737.2335745991154, 2746.5605503119405, 2755.8897644094013, 2768.9307767305577, 4684.032706263378, 4728.4562275338085, 4840.515948405131, 4845.878853028703, 4900.656954013256, 5315.813946511854, 5327.440618735054, 5327.760250788646, 5336.62643614951, 5337.532178650902, 4886.7067975920845, 4889.706617602884, 4902.90194196114, 4909.361782968192, 4909.656324057281, 4960.156773348467, 5183.3261675981885, 5190.55880250183, 5199.506046925536, 5219.217117432416, 5028.59771218309, 5066.4680208577565, 5080.288759573737, 5083.389993200692, 5093.71984540839, 4796.400449943757, 4847.297141914332, 4850.951490485191, 4871.48849370811, 4878.341423907727, 3439.8796042138406, 3636.2000359920776, 3685.926281474302, 3687.649673281034, 3691.427828686558, 5146.76839542229, 5163.845084647466, 5171.637985341141, 5175.767090480862, 5177.378714554277, 5004.324416203766, 5016.899662006813, 5029.547340739351, 5036.622253331088, 5049.914268432305, 4814.566688998007, 5010.348654674869, 5020.824271150492, 5038.420581633159, 5058.595312375075, 4931.778069986787, 4967.3542439482635, 4968.0, 4970.701757894538, 4974.403071631427, 5006.599472042155, 5008.899822003613, 5026.220935754964, 5070.416902056163, 5073.3911930568565, 4779.737114458738, 4926.0, 5049.772760225872, 5061.139606267017, 5072.67027643202], "value": 3804.5607475635125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.3788325324437, 660.3117863171481, 713.3829237709383, 725.1999522502091, 737.3769165055528, 12686.429110690018, 12794.68013299668, 13010.544630937908, 13125.081244312902, 13667.658308542279, 12817.230966142039, 12961.35193240339, 12987.545435909746, 13012.479500819956, 13020.023498237622, 638.5785381648113, 764.4686942574913, 772.6098320348231, 787.7321710618388, 798.9241022102891, 785.6189747972229, 788.5268838696765, 789.7117552093501, 790.782534802928, 791.2759824760337, 833.72487079264, 834.2158371131118, 834.7203686764941, 834.7370578267826, 835.2274146414572, 658.5390226841206, 805.1948051948052, 818.6888982186731, 821.3100995164091, 828.0394742099166, 604.619089973314, 604.9092636104575, 605.3220393159645, 605.8606520500309, 605.9060845568944, 13228.206307621573, 13288.933555332258, 13292.069555131146, 13296.601101966957, 13307.733845323137, 10750.623728169476, 10931.945340273327, 11070.723231919266, 11105.222634415593, 11216.663500094928, 10143.289969702124, 10168.745781355452, 10188.541515631814, 10248.12890904274, 10255.0, 3966.920661586781, 3976.9005774855573, 4049.6962727795535, 4090.836366545335, 4111.71218014739, 55135.72432137813, 55143.448565514234, 55379.44620553783, 55389.12276140672, 55411.72294138504, 9252.026437211622, 9446.0, 9511.191548718298, 9713.320067595341, 9836.803263934682, 17018.48944531666, 17028.829711702725, 17062.061586612854, 17184.226709798088, 17209.7418538722, 6473.385028422293, 6524.9673751630935, 6527.738890444424, 6616.073749675049, 6745.8650826983185, 3672.485851980725, 3690.8339124738914, 3707.647773461517, 3729.5151630288433, 3782.3002744492355, 2759.751622353998, 2844.9146525604265, 2863.9713602863703, 2871.4687782760257, 2878.0358579875556, 393.732262061795, 474.1749356120326, 474.2270099737406, 484.4211167654689, 486.0837321648718, 521.2363886905702, 526.6550409481796, 543.1987817968544, 557.2671936403616, 559.8124628249501, 7692.307692307607, 7856.607169641495, 7927.722529711547, 8288.958555207306, 8378.455400399076, 449.4696258415036, 486.34586481182754, 503.74560846772147, 519.7687029271938, 528.7673423693562, 3818.6754125899056, 3867.45855580219, 3870.53553573573, 3874.341361968472, 3983.2630963271886, 55465.722671386386, 56965.43034569601, 88304.5584772072, 90368.0, 90879.54560227157, 43455.34816977748, 44109.0, 44816.3277550837, 45521.772391137834, 45523.0, 63716.36283637197, 66675.66662166755, 67809.66095169492, 68647.0, 68871.65564172147, 7781.922180778346, 7858.960705196438, 8127.2279133482225, 8158.592070396575, 8329.416940814084, 40020.59979400169, 41539.37690934578, 41657.37513937354, 42095.57904420917, 42173.156536869705, 55869.0, 58337.70831145987, 59052.704736476044, 59433.40566594452, 61181.38818611757, 8824.11758824138, 10202.540885660015, 10217.795644086927, 10274.280800344202, 10934.726631834268, 12027.579034733742, 12529.49882004746, 13127.671808204872, 13505.324733763076, 13843.377048033064, 8814.2948564116, 11951.76096478083, 11967.341796201292, 12112.576059837864, 12316.630501084981, 12121.75756484883, 12339.75320493603, 12510.87489125097, 12607.306598137191, 12649.114561980574, 11673.649790506299, 11965.521379144737, 12198.390080495763, 12450.813237801622, 12480.687982800502, 9527.428354298487, 9625.540564777939, 9711.417314961125, 9800.509974501389, 9933.3543319684, 9611.231101512001, 9758.951205243928, 9759.9024009759, 10000.099991000845, 10053.19574434029], "value": 6231.598819062456, "unit": "score"}], "name": "dromaeo_css", "value": 6354.894510612522, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 109.0, 114.0, 114.0, 115.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 151.0, 134.0, 179.0, 133.0, 130.0, 150.0, 131.0, 205.0, 128.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0, 162.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 79.0, 120.0, 76.0, 77.0, 78.0, 75.0, 100.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 119.0, 86.0, 87.0, 86.0, 114.0, 86.0, 87.0, 131.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 116.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 150.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 65.0, 64.0, 63.0, 63.0, 62.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0, 64.0, 64.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 84.0, 86.0, 90.0, 85.0, 88.0, 115.0, 86.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 132.0, 127.0, 129.0, 130.0, 129.0, 129.0, 158.0, 133.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 170.0, 169.0, 175.0, 175.0, 171.0, 175.0, 169.0, 169.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 71.0, 67.0, 70.0, 67.0, 72.0, 67.0, 67.0, 78.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1556.1, "alertThreshold": 2.0}]} 02:07:12 INFO - Return code: 0 02:07:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:07:12 INFO - # TBPL SUCCESS # 02:07:12 INFO - Running post-action listener: _resource_record_post_action 02:07:12 INFO - ##### 02:07:12 INFO - ##### Finished run-tests step (success) 02:07:12 INFO - ##### 02:07:12 INFO - Running post-run listener: _resource_record_post_run 02:07:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 290234368; Read time: 12; Write time: 309508 02:07:13 INFO - TinderboxPrint: CPU usage
13.1% 02:07:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 02:07:13 INFO - TinderboxPrint: I/O write bytes / time
290,234,368 / 309,508 02:07:13 INFO - TinderboxPrint: CPU idle
8,331.9 (86.9%) 02:07:13 INFO - TinderboxPrint: CPU user
1,212.4 (12.6%) 02:07:13 INFO - TinderboxPrint: Swap in / out
0 / 0 02:07:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 6303744; Read time: 0; Write time: 544 02:07:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283930624; Read time: 12; Write time: 308964 02:07:13 INFO - Running post-run listener: _upload_blobber_files 02:07:13 INFO - Blob upload gear active. 02:07:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:07:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:07:14 INFO - (blobuploader) - INFO - Open directory for files ... 02:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:07:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:17 INFO - (blobuploader) - INFO - Done attempting. 02:07:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:07:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:18 INFO - (blobuploader) - INFO - Done attempting. 02:07:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:07:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:07:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:07:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:07:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:07:18 INFO - (blobuploader) - INFO - Done attempting. 02:07:18 INFO - (blobuploader) - INFO - Iteration through files over. 02:07:18 INFO - Return code: 0 02:07:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:07:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:07:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9bd7dea0c5c59009323895b3a2f870d40e06daf0a078c87514cf2ac62c36fec88ea6c2fec91662aaeb40f883867e332e0b583a4a2432289f0dcc73b8ae01f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e9cee106e03f24fbcc153ba714565c077e3216911442fc25a63c8134a88103a3cce974c5c7feaf898a42d21cedf74037657d9c81dbfb870bac770515bae98bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78db8a8ee190332064bedaa348ac2d0059f42d7812e41f378b84dfae40ed3ce38676571611bb0796a13e5b95e5db3d7a01374ef8dbf7be892b1ad9f24f4517e7"} 02:07:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:07:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:07:18 INFO - Contents: 02:07:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9bd7dea0c5c59009323895b3a2f870d40e06daf0a078c87514cf2ac62c36fec88ea6c2fec91662aaeb40f883867e332e0b583a4a2432289f0dcc73b8ae01f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e9cee106e03f24fbcc153ba714565c077e3216911442fc25a63c8134a88103a3cce974c5c7feaf898a42d21cedf74037657d9c81dbfb870bac770515bae98bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78db8a8ee190332064bedaa348ac2d0059f42d7812e41f378b84dfae40ed3ce38676571611bb0796a13e5b95e5db3d7a01374ef8dbf7be892b1ad9f24f4517e7"} 02:07:18 INFO - Running post-run listener: copy_logs_to_upload_dir 02:07:18 INFO - Copying logs to upload dir... 02:07:18 INFO - mkdir: /builds/slave/test/build/upload/logs 02:07:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.623466 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-06-21 02:07:18.914431) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 02:07:18.917903) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708 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/d9bd7dea0c5c59009323895b3a2f870d40e06daf0a078c87514cf2ac62c36fec88ea6c2fec91662aaeb40f883867e332e0b583a4a2432289f0dcc73b8ae01f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e9cee106e03f24fbcc153ba714565c077e3216911442fc25a63c8134a88103a3cce974c5c7feaf898a42d21cedf74037657d9c81dbfb870bac770515bae98bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78db8a8ee190332064bedaa348ac2d0059f42d7812e41f378b84dfae40ed3ce38676571611bb0796a13e5b95e5db3d7a01374ef8dbf7be892b1ad9f24f4517e7"} build_url:https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/VCDm0okbT5WBEsp79rUyhA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d9bd7dea0c5c59009323895b3a2f870d40e06daf0a078c87514cf2ac62c36fec88ea6c2fec91662aaeb40f883867e332e0b583a4a2432289f0dcc73b8ae01f87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e9cee106e03f24fbcc153ba714565c077e3216911442fc25a63c8134a88103a3cce974c5c7feaf898a42d21cedf74037657d9c81dbfb870bac770515bae98bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/78db8a8ee190332064bedaa348ac2d0059f42d7812e41f378b84dfae40ed3ce38676571611bb0796a13e5b95e5db3d7a01374ef8dbf7be892b1ad9f24f4517e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 02:07:18.942704) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:07:18.943005) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1466497698.619503-1434592708 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 02:07:19.028375) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:07:19.028695) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 02:07:19.028973) ========= ========= Total master_lag: 0.17 =========