builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-003 starttime: 1477946847.29 results: success (0) buildid: 20161031073047 builduid: ba4892c96ef94eb0965cab3c3aff4637 revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.294661) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.295178) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.295502) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.311093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.311568) ========= 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=7de08804244eb36560b44971000001c3-1477946846.125646-2061573111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-31 13:47:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-10-31 13:47:27 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.068257 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.394844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.395188) ========= 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=7de08804244eb36560b44971000001c3-1477946846.125646-2061573111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017805 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.450164) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:27.451045) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e017b947cea08b7bdd21007e95bd13e14ad59103 --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 e017b947cea08b7bdd21007e95bd13e14ad59103 --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=7de08804244eb36560b44971000001c3-1477946846.125646-2061573111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-31 13:47:27,657 truncating revision to first 12 chars 2016-10-31 13:47:27,657 Setting DEBUG logging. 2016-10-31 13:47:27,657 attempt 1/10 2016-10-31 13:47:27,657 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e017b947cea0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-31 13:47:27,965 unpacking tar archive at: fx-team-e017b947cea0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.620796 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:28.092327) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:28.092766) ========= script_repo_revision: e017b947cea08b7bdd21007e95bd13e14ad59103 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:28.093250) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:28.093568) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-31 13:47:28.105108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-31 13:47:28.105664) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=7de08804244eb36560b44971000001c3-1477946846.125646-2061573111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:47:28 INFO - MultiFileLogger online at 20161031 13:47:28 in /builds/slave/test 13:47:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 13:47:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:47:28 INFO - {'append_to_log': False, 13:47:28 INFO - 'base_work_dir': '/builds/slave/test', 13:47:28 INFO - 'blob_upload_branch': 'Fx-Team', 13:47:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:47:28 INFO - 'branch': 'Fx-Team', 13:47:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:47:28 INFO - 'config_files': ('talos/linux_config.py',), 13:47:28 INFO - 'default_actions': ('clobber', 13:47:28 INFO - 'read-buildbot-config', 13:47:28 INFO - 'download-and-extract', 13:47:28 INFO - 'populate-webroot', 13:47:28 INFO - 'create-virtualenv', 13:47:28 INFO - 'install', 13:47:28 INFO - 'run-tests'), 13:47:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:47:28 INFO - 'download_minidump_stackwalk': True, 13:47:28 INFO - 'download_symbols': 'ondemand', 13:47:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:47:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:47:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:47:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:47:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:47:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:47:28 INFO - 'installer_path': 'installer.exe', 13:47:28 INFO - 'log_level': 'info', 13:47:28 INFO - 'log_name': 'talos', 13:47:28 INFO - 'log_to_console': True, 13:47:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:47:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:47:28 INFO - 'opt_config_files': (), 13:47:28 INFO - 'pip_index': False, 13:47:28 INFO - 'sps_profile': False, 13:47:28 INFO - 'sps_profile_interval': 0, 13:47:28 INFO - 'suite': 'dromaeojs-e10s', 13:47:28 INFO - 'system_bits': '32', 13:47:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:47:28 INFO - 'title': 'talos-linux64-ix-003', 13:47:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:47:28 INFO - 'use_talos_json': True, 13:47:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:47:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:47:28 INFO - 'work_dir': 'build'} 13:47:28 INFO - [mozharness: 2016-10-31 20:47:28.398053Z] Running clobber step. 13:47:28 INFO - Running pre-action listener: _resource_record_pre_action 13:47:28 INFO - Running main action method: clobber 13:47:28 INFO - rmtree: /builds/slave/test/build 13:47:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:47:29 INFO - Running post-action listener: _resource_record_post_action 13:47:29 INFO - [mozharness: 2016-10-31 20:47:29.367661Z] Finished clobber step (success) 13:47:29 INFO - [mozharness: 2016-10-31 20:47:29.367761Z] Running read-buildbot-config step. 13:47:29 INFO - Running pre-action listener: _resource_record_pre_action 13:47:29 INFO - Running main action method: read_buildbot_config 13:47:29 INFO - Using buildbot properties: 13:47:29 INFO - { 13:47:29 INFO - "project": "", 13:47:29 INFO - "product": "firefox", 13:47:29 INFO - "script_repo_revision": "production", 13:47:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:47:29 INFO - "repository": "", 13:47:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 13:47:29 INFO - "buildid": "20161031073047", 13:47:29 INFO - "stage_platform": "linux64-pgo", 13:47:29 INFO - "basedir": "/builds/slave/test", 13:47:29 INFO - "buildnumber": 880, 13:47:29 INFO - "platform": "ubuntu64_hw", 13:47:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:47:29 INFO - "slavebuilddir": "test", 13:47:29 INFO - "branch": "fx-team", 13:47:29 INFO - "revision": "e017b947cea08b7bdd21007e95bd13e14ad59103", 13:47:29 INFO - "slavename": "talos-linux64-ix-003", 13:47:29 INFO - "builduid": "ba4892c96ef94eb0965cab3c3aff4637", 13:47:29 INFO - "repo_path": "integration/fx-team" 13:47:29 INFO - } 13:47:29 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:47:29 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 13:47:29 INFO - Running post-action listener: _resource_record_post_action 13:47:29 INFO - [mozharness: 2016-10-31 20:47:29.370124Z] Finished read-buildbot-config step (success) 13:47:29 INFO - [mozharness: 2016-10-31 20:47:29.370212Z] Running download-and-extract step. 13:47:29 INFO - Running pre-action listener: _resource_record_pre_action 13:47:29 INFO - Running main action method: download_and_extract 13:47:29 INFO - mkdir: /builds/slave/test/build/tests 13:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:29 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:47:29 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:47:29 INFO - Downloaded 1361 bytes. 13:47:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:47:29 INFO - Using the following test package requirements: 13:47:29 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:29 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:47:29 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:47:29 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'jsshell-linux-x86_64.zip'], 13:47:29 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:47:29 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:47:29 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:47:29 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:47:29 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:47:29 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:47:29 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:47:29 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:47:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:47:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:47:29 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:47:29 INFO - Http code: 200 13:47:29 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 13:47:29 INFO - x-amz-cf-id: 7f6occPSQHwjHwRBcf2HtlFRrpfDQq5Ly0UtiLGk-5nvr8bOSGj-zQ== 13:47:29 INFO - x-amz-replication-status: PENDING 13:47:29 INFO - x-amz-version-id: y31BQrNdTWPkjV6bE.oIf9Bzhl9oa4xO 13:47:29 INFO - Expected file size: 22006771 13:47:29 INFO - Obtained file size: 22006771 13:47:33 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:47:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:47:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:47:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:47:33 INFO - Http code: 200 13:47:33 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 13:47:33 INFO - x-amz-cf-id: V2Ap_7dllZT7XGi2Qwh-Yjzen7sZvtd032a_64LC1RMNTgo9nTNRbw== 13:47:33 INFO - x-amz-replication-status: PENDING 13:47:33 INFO - x-amz-version-id: y31BQrNdTWPkjV6bE.oIf9Bzhl9oa4xO 13:47:34 INFO - Expected file size: 22006771 13:47:34 INFO - Obtained file size: 22006771 13:47:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:47:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:47:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:47:39 INFO - Http code: 200 13:47:39 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 13:47:39 INFO - x-amz-cf-id: zvh2Ine2A55mPewbB1nlmF-Tc6rkAg-0t44Spu14Ja2HZYT5nlpiIw== 13:47:39 INFO - x-amz-replication-status: PENDING 13:47:39 INFO - x-amz-version-id: si55E5g.tWpWncDMLoPLIj9kMv5S1DyA 13:47:39 INFO - Expected file size: 14409038 13:47:39 INFO - Obtained file size: 14409038 13:47:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:39 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:47:39 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:47:40 INFO - Downloaded 59606250 bytes. 13:47:40 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:47:40 INFO - mkdir: /builds/slave/test/properties 13:47:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:47:40 INFO - Writing to file /builds/slave/test/properties/build_url 13:47:40 INFO - Contents: 13:47:40 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:47:40 INFO - Running post-action listener: _resource_record_post_action 13:47:40 INFO - Running post-action listener: set_extra_try_arguments 13:47:40 INFO - [mozharness: 2016-10-31 20:47:40.737081Z] Finished download-and-extract step (success) 13:47:40 INFO - [mozharness: 2016-10-31 20:47:40.737307Z] Running populate-webroot step. 13:47:40 INFO - Running pre-action listener: _resource_record_pre_action 13:47:40 INFO - Running main action method: populate_webroot 13:47:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:47:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:47:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:47:40 INFO - '--tppagecycles', 13:47:40 INFO - '7'], 13:47:40 INFO - 'tests': ['tsvgm']}}, 13:47:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:47:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:47:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:47:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:47:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:47:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['damp', 'tps']}, 13:47:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'tests': ['damp', 'tps']}, 13:47:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['dromaeo_dom']}, 13:47:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:47:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['basic_compositor_video']}, 13:47:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:47:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['a11yr', 13:47:40 INFO - 'ts_paint', 13:47:40 INFO - 'tpaint', 13:47:40 INFO - 'sessionrestore', 13:47:40 INFO - 'sessionrestore_no_auto_restore', 13:47:40 INFO - 'tabpaint']}, 13:47:40 INFO - 'other-e10s': {'tests': ['a11yr', 13:47:40 INFO - 'ts_paint', 13:47:40 INFO - 'tpaint', 13:47:40 INFO - 'sessionrestore', 13:47:40 INFO - 'sessionrestore_no_auto_restore', 13:47:40 INFO - 'tabpaint']}, 13:47:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:47:40 INFO - 'ts_paint', 13:47:40 INFO - 'tpaint', 13:47:40 INFO - 'sessionrestore', 13:47:40 INFO - 'sessionrestore_no_auto_restore', 13:47:40 INFO - 'tabpaint']}, 13:47:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:47:40 INFO - 'ts_paint', 13:47:40 INFO - 'tpaint', 13:47:40 INFO - 'sessionrestore', 13:47:40 INFO - 'sessionrestore_no_auto_restore', 13:47:40 INFO - 'tabpaint']}, 13:47:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['a11yr', 13:47:40 INFO - 'ts_paint', 13:47:40 INFO - 'tpaint', 13:47:40 INFO - 'sessionrestore', 13:47:40 INFO - 'sessionrestore_no_auto_restore', 13:47:40 INFO - 'tabpaint']}, 13:47:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['a11yr', 13:47:40 INFO - 'ts_paint', 13:47:40 INFO - 'tpaint', 13:47:40 INFO - 'sessionrestore', 13:47:40 INFO - 'sessionrestore_no_auto_restore', 13:47:40 INFO - 'tabpaint']}, 13:47:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['tsvgx', 13:47:40 INFO - 'tsvgr_opacity', 13:47:40 INFO - 'tart', 13:47:40 INFO - 'tscrollx', 13:47:40 INFO - 'cart']}, 13:47:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:47:40 INFO - 'tsvgr_opacity', 13:47:40 INFO - 'tart', 13:47:40 INFO - 'tscrollx', 13:47:40 INFO - 'cart']}, 13:47:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'talos_options': ['--disable-e10s'], 13:47:40 INFO - 'tests': ['tp5o']}, 13:47:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'tests': ['tp5o']}, 13:47:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'talos_options': ['--disable-e10s', 13:47:40 INFO - '--xperf_path', 13:47:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:40 INFO - 'tests': ['tp5n']}, 13:47:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:47:40 INFO - 'talos_options': ['--xperf_path', 13:47:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:47:40 INFO - 'tests': ['tp5n']}}, 13:47:40 INFO - 'talos.zip': {'path': '', 13:47:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:47:40 INFO - Running post-action listener: _resource_record_post_action 13:47:40 INFO - [mozharness: 2016-10-31 20:47:40.753494Z] Finished populate-webroot step (success) 13:47:40 INFO - [mozharness: 2016-10-31 20:47:40.753582Z] Running create-virtualenv step. 13:47:40 INFO - Running pre-action listener: _resource_record_pre_action 13:47:40 INFO - Running main action method: create_virtualenv 13:47:40 INFO - Creating virtualenv /builds/slave/test/build/venv 13:47:40 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 13:47:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:47:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:47:40 INFO - Using real prefix '/usr' 13:47:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:47:41 INFO - Installing distribute.............................................................................................................................................................................................done. 13:47:43 INFO - Installing pip.................done. 13:47:43 INFO - Return code: 0 13:47:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:47:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:47:43 INFO - Reading from file tmpfile_stdout 13:47:43 INFO - Output received: 13:47:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:47:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:43 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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47:43 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 13:47:43 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 13:47:43 INFO - Using env: {'DISPLAY': ':0', 13:47:43 INFO - 'HOME': '/home/cltbld', 13:47:43 INFO - 'LANG': 'en_US.UTF-8', 13:47:43 INFO - 'LANGUAGE': 'en_US:en', 13:47:43 INFO - 'LOGNAME': 'cltbld', 13:47:43 INFO - 'MAIL': '/var/mail/cltbld', 13:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:43 INFO - 'MOZ_NO_REMOTE': '1', 13:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:43 INFO - 'NO_EM_RESTART': '1', 13:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:43 INFO - 'PWD': '/builds/slave/test', 13:47:43 INFO - 'SHELL': '/bin/bash', 13:47:43 INFO - 'SHLVL': '1', 13:47:43 INFO - 'TERM': 'linux', 13:47:43 INFO - 'TMOUT': '86400', 13:47:43 INFO - 'USER': 'cltbld', 13:47:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:43 INFO - '_': '/tools/buildbot/bin/python'} 13:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:43 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 13:47:43 INFO - Cleaning up... 13:47:43 INFO - Return code: 0 13:47:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:43 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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47:43 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 13:47:43 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 13:47:43 INFO - Using env: {'DISPLAY': ':0', 13:47:43 INFO - 'HOME': '/home/cltbld', 13:47:43 INFO - 'LANG': 'en_US.UTF-8', 13:47:43 INFO - 'LANGUAGE': 'en_US:en', 13:47:43 INFO - 'LOGNAME': 'cltbld', 13:47:43 INFO - 'MAIL': '/var/mail/cltbld', 13:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:43 INFO - 'MOZ_NO_REMOTE': '1', 13:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:43 INFO - 'NO_EM_RESTART': '1', 13:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:43 INFO - 'PWD': '/builds/slave/test', 13:47:43 INFO - 'SHELL': '/bin/bash', 13:47:43 INFO - 'SHLVL': '1', 13:47:43 INFO - 'TERM': 'linux', 13:47:43 INFO - 'TMOUT': '86400', 13:47:43 INFO - 'USER': 'cltbld', 13:47:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:43 INFO - '_': '/tools/buildbot/bin/python'} 13:47:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:43 INFO - Downloading/unpacking psutil>=3.1.1 13:47:43 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 13:47:43 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 13:47:43 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 13:47:43 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 13:47:43 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 13:47:43 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 13:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:47:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:46 INFO - Installing collected packages: psutil 13:47:46 INFO - Running setup.py install for psutil 13:47:46 INFO - building 'psutil._psutil_linux' extension 13:47:46 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 13:47:46 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 13:47:46 INFO - building 'psutil._psutil_posix' extension 13:47:46 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 13:47:46 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 13:47:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:47:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:47:46 INFO - Successfully installed psutil 13:47:46 INFO - Cleaning up... 13:47:46 INFO - Return code: 0 13:47:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:47:46 INFO - Using env: {'DISPLAY': ':0', 13:47:46 INFO - 'HOME': '/home/cltbld', 13:47:46 INFO - 'LANG': 'en_US.UTF-8', 13:47:46 INFO - 'LANGUAGE': 'en_US:en', 13:47:46 INFO - 'LOGNAME': 'cltbld', 13:47:46 INFO - 'MAIL': '/var/mail/cltbld', 13:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:46 INFO - 'MOZ_NO_REMOTE': '1', 13:47:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:46 INFO - 'NO_EM_RESTART': '1', 13:47:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:46 INFO - 'PWD': '/builds/slave/test', 13:47:46 INFO - 'SHELL': '/bin/bash', 13:47:46 INFO - 'SHLVL': '1', 13:47:46 INFO - 'TERM': 'linux', 13:47:46 INFO - 'TMOUT': '86400', 13:47:46 INFO - 'USER': 'cltbld', 13:47:46 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:46 INFO - '_': '/tools/buildbot/bin/python'} 13:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:47:46 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 13:47:46 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 13:47:46 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 13:47:46 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 13:47:46 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 13:47:46 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 13:47:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:47:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:47:48 INFO - Installing collected packages: mozsystemmonitor 13:47:48 INFO - Running setup.py install for mozsystemmonitor 13:47:48 INFO - Successfully installed mozsystemmonitor 13:47:48 INFO - Cleaning up... 13:47:48 INFO - Return code: 0 13:47:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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', '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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:47: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 jsonschema==2.5.1 13:47:48 INFO - Using env: {'DISPLAY': ':0', 13:47:48 INFO - 'HOME': '/home/cltbld', 13:47:48 INFO - 'LANG': 'en_US.UTF-8', 13:47:48 INFO - 'LANGUAGE': 'en_US:en', 13:47:48 INFO - 'LOGNAME': 'cltbld', 13:47:48 INFO - 'MAIL': '/var/mail/cltbld', 13:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:48 INFO - 'MOZ_NO_REMOTE': '1', 13:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:48 INFO - 'NO_EM_RESTART': '1', 13:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:48 INFO - 'PWD': '/builds/slave/test', 13:47:48 INFO - 'SHELL': '/bin/bash', 13:47:48 INFO - 'SHLVL': '1', 13:47:48 INFO - 'TERM': 'linux', 13:47:48 INFO - 'TMOUT': '86400', 13:47:48 INFO - 'USER': 'cltbld', 13:47:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:48 INFO - '_': '/tools/buildbot/bin/python'} 13:47:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:49 INFO - Downloading/unpacking jsonschema==2.5.1 13:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:47:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47:51 INFO - Downloading functools32-3.2.3-2.tar.gz 13:47:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:47:51 INFO - warning: no files found matching '*.txt' 13:47:51 INFO - no previously-included directories found matching 'build' 13:47:51 INFO - no previously-included directories found matching 'dist' 13:47:51 INFO - no previously-included directories found matching '.git*' 13:47:51 INFO - Installing collected packages: jsonschema, functools32 13:47:51 INFO - Running setup.py install for functools32 13:47:51 INFO - warning: no files found matching '*.txt' 13:47:51 INFO - no previously-included directories found matching 'build' 13:47:51 INFO - no previously-included directories found matching 'dist' 13:47:51 INFO - no previously-included directories found matching '.git*' 13:47:51 INFO - Successfully installed jsonschema functools32 13:47:51 INFO - Cleaning up... 13:47:51 INFO - Return code: 0 13:47:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:47: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 functools32==3.2.3-2 13:47:51 INFO - Using env: {'DISPLAY': ':0', 13:47:51 INFO - 'HOME': '/home/cltbld', 13:47:51 INFO - 'LANG': 'en_US.UTF-8', 13:47:51 INFO - 'LANGUAGE': 'en_US:en', 13:47:51 INFO - 'LOGNAME': 'cltbld', 13:47:51 INFO - 'MAIL': '/var/mail/cltbld', 13:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:51 INFO - 'MOZ_NO_REMOTE': '1', 13:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:51 INFO - 'NO_EM_RESTART': '1', 13:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:51 INFO - 'PWD': '/builds/slave/test', 13:47:51 INFO - 'SHELL': '/bin/bash', 13:47:51 INFO - 'SHLVL': '1', 13:47:51 INFO - 'TERM': 'linux', 13:47:51 INFO - 'TMOUT': '86400', 13:47:51 INFO - 'USER': 'cltbld', 13:47:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:51 INFO - '_': '/tools/buildbot/bin/python'} 13:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:47:51 INFO - Cleaning up... 13:47:51 INFO - Return code: 0 13:47:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47: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', '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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:47: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 blobuploader==1.2.4 13:47:51 INFO - Using env: {'DISPLAY': ':0', 13:47:51 INFO - 'HOME': '/home/cltbld', 13:47:51 INFO - 'LANG': 'en_US.UTF-8', 13:47:51 INFO - 'LANGUAGE': 'en_US:en', 13:47:51 INFO - 'LOGNAME': 'cltbld', 13:47:51 INFO - 'MAIL': '/var/mail/cltbld', 13:47:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:51 INFO - 'MOZ_NO_REMOTE': '1', 13:47:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:51 INFO - 'NO_EM_RESTART': '1', 13:47:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:51 INFO - 'PWD': '/builds/slave/test', 13:47:51 INFO - 'SHELL': '/bin/bash', 13:47:51 INFO - 'SHLVL': '1', 13:47:51 INFO - 'TERM': 'linux', 13:47:51 INFO - 'TMOUT': '86400', 13:47:51 INFO - 'USER': 'cltbld', 13:47:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:51 INFO - '_': '/tools/buildbot/bin/python'} 13:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:51 INFO - Downloading/unpacking blobuploader==1.2.4 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47:53 INFO - Downloading blobuploader-1.2.4.tar.gz 13:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:47:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47: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 13:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:47:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:47:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:47:54 INFO - Downloading docopt-0.6.1.tar.gz 13:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:47:54 INFO - Installing collected packages: blobuploader, requests, docopt 13:47:54 INFO - Running setup.py install for blobuploader 13:47:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:47:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:47:54 INFO - Running setup.py install for requests 13:47:55 INFO - Running setup.py install for docopt 13:47:55 INFO - Successfully installed blobuploader requests docopt 13:47:55 INFO - Cleaning up... 13:47:55 INFO - Return code: 0 13:47:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:55 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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47:55 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 13:47:55 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 13:47:55 INFO - Using env: {'DISPLAY': ':0', 13:47:55 INFO - 'HOME': '/home/cltbld', 13:47:55 INFO - 'LANG': 'en_US.UTF-8', 13:47:55 INFO - 'LANGUAGE': 'en_US:en', 13:47:55 INFO - 'LOGNAME': 'cltbld', 13:47:55 INFO - 'MAIL': '/var/mail/cltbld', 13:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:55 INFO - 'MOZ_NO_REMOTE': '1', 13:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:55 INFO - 'NO_EM_RESTART': '1', 13:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:55 INFO - 'PWD': '/builds/slave/test', 13:47:55 INFO - 'SHELL': '/bin/bash', 13:47:55 INFO - 'SHLVL': '1', 13:47:55 INFO - 'TERM': 'linux', 13:47:55 INFO - 'TMOUT': '86400', 13:47:55 INFO - 'USER': 'cltbld', 13:47:55 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:55 INFO - '_': '/tools/buildbot/bin/python'} 13:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:55 INFO - Running setup.py (path:/tmp/pip-iXnoB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:55 INFO - Running setup.py (path:/tmp/pip-jwd2TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:55 INFO - Running setup.py (path:/tmp/pip-_8fuPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:55 INFO - Running setup.py (path:/tmp/pip-yyVqa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:55 INFO - Running setup.py (path:/tmp/pip-sing7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:55 INFO - Running setup.py (path:/tmp/pip-0O2mA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:55 INFO - Running setup.py (path:/tmp/pip-B1rDVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:56 INFO - Running setup.py (path:/tmp/pip-vWngpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:56 INFO - Running setup.py (path:/tmp/pip-gENFha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:56 INFO - Running setup.py (path:/tmp/pip-PLRnb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:56 INFO - Running setup.py (path:/tmp/pip-WoQbpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:56 INFO - Running setup.py (path:/tmp/pip-J9Vdzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:56 INFO - Running setup.py (path:/tmp/pip-R44o8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:56 INFO - Running setup.py (path:/tmp/pip-QPdrpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:56 INFO - Running setup.py (path:/tmp/pip-ku4fJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:56 INFO - Running setup.py (path:/tmp/pip-yDu3p9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:56 INFO - Running setup.py (path:/tmp/pip-629HUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:47:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:47:56 INFO - Running setup.py install for manifestparser 13:47:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:47:56 INFO - Running setup.py install for mozcrash 13:47:56 INFO - Running setup.py install for mozdebug 13:47:57 INFO - Running setup.py install for mozdevice 13:47:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Running setup.py install for mozfile 13:47:57 INFO - Running setup.py install for mozhttpd 13:47:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Running setup.py install for mozinfo 13:47:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Running setup.py install for mozInstall 13:47:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Running setup.py install for mozleak 13:47:57 INFO - Running setup.py install for mozlog 13:47:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Running setup.py install for moznetwork 13:47:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:47:57 INFO - Running setup.py install for mozprocess 13:47:57 INFO - Running setup.py install for mozprofile 13:47:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:47:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:47:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:47:58 INFO - Running setup.py install for mozrunner 13:47:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:47:58 INFO - Running setup.py install for mozscreenshot 13:47:58 INFO - Running setup.py install for moztest 13:47:58 INFO - Running setup.py install for mozversion 13:47:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:47:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:47:58 INFO - Cleaning up... 13:47:58 INFO - Return code: 0 13:47:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:47:58 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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:47:58 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 13:47:58 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 13:47:58 INFO - Using env: {'DISPLAY': ':0', 13:47:58 INFO - 'HOME': '/home/cltbld', 13:47:58 INFO - 'LANG': 'en_US.UTF-8', 13:47:58 INFO - 'LANGUAGE': 'en_US:en', 13:47:58 INFO - 'LOGNAME': 'cltbld', 13:47:58 INFO - 'MAIL': '/var/mail/cltbld', 13:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:47:58 INFO - 'MOZ_NO_REMOTE': '1', 13:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:47:58 INFO - 'NO_EM_RESTART': '1', 13:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:47:58 INFO - 'PWD': '/builds/slave/test', 13:47:58 INFO - 'SHELL': '/bin/bash', 13:47:58 INFO - 'SHLVL': '1', 13:47:58 INFO - 'TERM': 'linux', 13:47:58 INFO - 'TMOUT': '86400', 13:47:58 INFO - 'USER': 'cltbld', 13:47:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:47:58 INFO - '_': '/tools/buildbot/bin/python'} 13:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:47:58 INFO - Running setup.py (path:/tmp/pip-qQ28FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:47:58 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)) 13:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:47:58 INFO - Running setup.py (path:/tmp/pip-7x4KrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:47:58 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)) 13:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:47:58 INFO - Running setup.py (path:/tmp/pip-Iya0XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:47:59 INFO - Running setup.py (path:/tmp/pip-Mj0rFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:47:59 INFO - Running setup.py (path:/tmp/pip-B_cV8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:47:59 INFO - Running setup.py (path:/tmp/pip-SviVaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:47:59 INFO - Running setup.py (path:/tmp/pip-6PHbQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:47:59 INFO - Running setup.py (path:/tmp/pip-tBntIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:47:59 INFO - Running setup.py (path:/tmp/pip-iDulEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:47:59 INFO - Running setup.py (path:/tmp/pip-rOewpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:47:59 INFO - Running setup.py (path:/tmp/pip-PBJhCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:47:59 INFO - Running setup.py (path:/tmp/pip-9JaQmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:47:59 INFO - Running setup.py (path:/tmp/pip-OYbKDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:47:59 INFO - Running setup.py (path:/tmp/pip-N4y8o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:59 INFO - Running setup.py (path:/tmp/pip-xPIHxN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:47:59 INFO - Running setup.py (path:/tmp/pip-ho2VyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:47:59 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)) 13:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:47:59 INFO - Running setup.py (path:/tmp/pip-gp6jzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:48:00 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)) 13:48:00 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)) 13:48:00 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)) 13:48:00 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)) 13:48:00 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)) 13:48:00 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)) 13:48:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:01 INFO - Downloading blessings-1.6.tar.gz 13:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:48:02 INFO - Installing collected packages: blessings 13:48:02 INFO - Running setup.py install for blessings 13:48:02 INFO - Successfully installed blessings 13:48:02 INFO - Cleaning up... 13:48:02 INFO - Return code: 0 13:48:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:48:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:48:02 INFO - Reading from file tmpfile_stdout 13:48:02 INFO - Current package versions: 13:48:02 INFO - argparse == 1.2.1 13:48:02 INFO - blessings == 1.6 13:48:02 INFO - blobuploader == 1.2.4 13:48:02 INFO - docopt == 0.6.1 13:48:02 INFO - functools32 == 3.2.3-2 13:48:02 INFO - jsonschema == 2.5.1 13:48:02 INFO - manifestparser == 1.1 13:48:02 INFO - mozInstall == 1.12 13:48:02 INFO - mozcrash == 0.17 13:48:02 INFO - mozdebug == 0.1 13:48:02 INFO - mozdevice == 0.48 13:48:02 INFO - mozfile == 1.2 13:48:02 INFO - mozhttpd == 0.7 13:48:02 INFO - mozinfo == 0.9 13:48:02 INFO - mozleak == 0.1 13:48:02 INFO - mozlog == 3.4 13:48:02 INFO - moznetwork == 0.27 13:48:02 INFO - mozprocess == 0.23 13:48:02 INFO - mozprofile == 0.28 13:48:02 INFO - mozrunner == 6.12 13:48:02 INFO - mozscreenshot == 0.1 13:48:02 INFO - mozsystemmonitor == 0.3 13:48:02 INFO - moztest == 0.7 13:48:02 INFO - mozversion == 1.4 13:48:02 INFO - psutil == 3.1.1 13:48:02 INFO - requests == 1.2.3 13:48:02 INFO - wsgiref == 0.1.2 13:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:02 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 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:48:02 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 13:48:02 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 13:48:02 INFO - Using env: {'DISPLAY': ':0', 13:48:02 INFO - 'HOME': '/home/cltbld', 13:48:02 INFO - 'LANG': 'en_US.UTF-8', 13:48:02 INFO - 'LANGUAGE': 'en_US:en', 13:48:02 INFO - 'LOGNAME': 'cltbld', 13:48:02 INFO - 'MAIL': '/var/mail/cltbld', 13:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:02 INFO - 'MOZ_NO_REMOTE': '1', 13:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:02 INFO - 'NO_EM_RESTART': '1', 13:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:02 INFO - 'PWD': '/builds/slave/test', 13:48:02 INFO - 'SHELL': '/bin/bash', 13:48:02 INFO - 'SHLVL': '1', 13:48:02 INFO - 'TERM': 'linux', 13:48:02 INFO - 'TMOUT': '86400', 13:48:02 INFO - 'USER': 'cltbld', 13:48:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:02 INFO - '_': '/tools/buildbot/bin/python'} 13:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 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)) 13:48:02 INFO - Cleaning up... 13:48:02 INFO - Return code: 0 13:48:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0191c06f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23527b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, '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': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', '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 13:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:48:02 INFO - Using env: {'DISPLAY': ':0', 13:48:02 INFO - 'HOME': '/home/cltbld', 13:48:02 INFO - 'LANG': 'en_US.UTF-8', 13:48:02 INFO - 'LANGUAGE': 'en_US:en', 13:48:02 INFO - 'LOGNAME': 'cltbld', 13:48:02 INFO - 'MAIL': '/var/mail/cltbld', 13:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:02 INFO - 'MOZ_NO_REMOTE': '1', 13:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:02 INFO - 'NO_EM_RESTART': '1', 13:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:02 INFO - 'PWD': '/builds/slave/test', 13:48:02 INFO - 'SHELL': '/bin/bash', 13:48:02 INFO - 'SHLVL': '1', 13:48:02 INFO - 'TERM': 'linux', 13:48:02 INFO - 'TMOUT': '86400', 13:48:02 INFO - 'USER': 'cltbld', 13:48:02 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:02 INFO - '_': '/tools/buildbot/bin/python'} 13:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:48:02 INFO - Cleaning up... 13:48:02 INFO - Return code: 0 13:48:02 INFO - Running post-action listener: _resource_record_post_action 13:48:02 INFO - Running post-action listener: _start_resource_monitoring 13:48:02 INFO - Starting resource monitoring. 13:48:02 INFO - [mozharness: 2016-10-31 20:48:02.934700Z] Finished create-virtualenv step (success) 13:48:02 INFO - [mozharness: 2016-10-31 20:48:02.935213Z] Running install step. 13:48:02 INFO - Running pre-action listener: _resource_record_pre_action 13:48:02 INFO - Running main action method: install 13:48:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:48:03 INFO - Reading from file tmpfile_stdout 13:48:03 INFO - Detecting whether we're running mozinstall >=1.0... 13:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:48:03 INFO - Reading from file tmpfile_stdout 13:48:03 INFO - Output received: 13:48:03 INFO - Usage: mozinstall [options] installer 13:48:03 INFO - Options: 13:48:03 INFO - -h, --help show this help message and exit 13:48:03 INFO - -d DEST, --destination=DEST 13:48:03 INFO - Directory to install application into. [default: 13:48:03 INFO - "/builds/slave/test"] 13:48:03 INFO - --app=APP Application being installed. [default: firefox] 13:48:03 INFO - mkdir: /builds/slave/test/build/application 13:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:48:20 INFO - Reading from file tmpfile_stdout 13:48:20 INFO - Output received: 13:48:20 INFO - /builds/slave/test/build/application/firefox/firefox 13:48:20 INFO - Running post-action listener: _resource_record_post_action 13:48:20 INFO - [mozharness: 2016-10-31 20:48:20.624825Z] Finished install step (success) 13:48:20 INFO - [mozharness: 2016-10-31 20:48:20.625072Z] Running run-tests step. 13:48:20 INFO - Running pre-action listener: _resource_record_pre_action 13:48:20 INFO - Running main action method: run_tests 13:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:48:20 INFO - Python 2.7.3 13:48:20 INFO - Return code: 0 13:48:20 INFO - grabbing minidump binary from tooltool 13:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:20 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23e1790>, '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 0x23e2690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:48:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:48:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 13:48:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:48:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:48:20 INFO - Return code: 0 13:48:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:48:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:48:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:48:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:48:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:48:20 INFO - Using env: {'DISPLAY': ':0', 13:48:20 INFO - 'HOME': '/home/cltbld', 13:48:20 INFO - 'LANG': 'en_US.UTF-8', 13:48:20 INFO - 'LANGUAGE': 'en_US:en', 13:48:20 INFO - 'LOGNAME': 'cltbld', 13:48:20 INFO - 'MAIL': '/var/mail/cltbld', 13:48:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:48:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:20 INFO - 'MOZ_NO_REMOTE': '1', 13:48:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:48:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:48:20 INFO - 'NO_EM_RESTART': '1', 13:48:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:20 INFO - 'PWD': '/builds/slave/test', 13:48:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:48:20 INFO - 'SHELL': '/bin/bash', 13:48:20 INFO - 'SHLVL': '1', 13:48:20 INFO - 'TERM': 'linux', 13:48:20 INFO - 'TMOUT': '86400', 13:48:20 INFO - 'USER': 'cltbld', 13:48:20 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1477946846.125646-2061573111', 13:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:20 INFO - '_': '/tools/buildbot/bin/python'} 13:48:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:48:20 INFO - mozversion application_buildid: 20161030213030 13:48:20 INFO - mozversion application_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 13:48:20 INFO - mozversion application_display_name: Nightly 13:48:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:48:20 INFO - mozversion application_name: Firefox 13:48:20 INFO - mozversion application_remotingname: firefox 13:48:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:48:20 INFO - mozversion application_vendor: Mozilla 13:48:20 INFO - mozversion application_version: 52.0a1 13:48:20 INFO - mozversion platform_buildid: 20161030213030 13:48:20 INFO - mozversion platform_changeset: e017b947cea08b7bdd21007e95bd13e14ad59103 13:48:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:48:20 INFO - mozversion platform_version: 52.0a1 13:48:20 INFO - using testdate: 1477946900 13:48:20 INFO - actual date: 1477946900 13:48:20 INFO - starting webserver on 'localhost:43470' 13:48:20 INFO - SUITE-START | Running 2 tests 13:48:20 INFO - TEST-START | dromaeo_css 13:48:20 INFO - operating with platform_type : linux_ 13:48:20 INFO - Initialising browser for dromaeo_css test... 13:48:20 INFO - TEST-INFO | started process 21135 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MO505/profile http://localhost:43470/getInfo.html) 13:48:25 INFO - PROCESS | 21135 | __metrics Screen width/height:1600/1200 13:48:25 INFO - PROCESS | 21135 | colorDepth:24 13:48:25 INFO - PROCESS | 21135 | Browser inner width/height: 1024/697 13:48:25 INFO - PROCESS | 21135 | __metrics 13:48:26 ERROR - PROCESS | 21135 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 13:48:27 INFO - TEST-INFO | 21135: exit 0 13:48:27 INFO - Browser initialized. 13:48:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:48:27 INFO - TEST-INFO | started process 21258 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5MO505/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:48:39 INFO - PROCESS | 21258 | RSS: Main: 187539456 13:48:39 INFO - PROCESS | 21258 | 13:49:29 INFO - PROCESS | 21258 | 1477946969068 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] 13:51:40 INFO - PROCESS | 21258 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43470/tests/dromaeo/cssquery-ext.html) 13:51:41 INFO - PROCESS | 21258 | RSS: Main: 199503872 13:51:41 INFO - PROCESS | 21258 | 13:54:43 INFO - PROCESS | 21258 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-ext.html (next: http://localhost:43470/tests/dromaeo/cssquery-jquery.html) 13:54:44 INFO - PROCESS | 21258 | RSS: Main: 197251072 13:54:44 INFO - PROCESS | 21258 | 13:57:45 INFO - PROCESS | 21258 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43470/tests/dromaeo/cssquery-mootools.html) 13:57:46 INFO - PROCESS | 21258 | RSS: Main: 200122368 13:57:46 INFO - PROCESS | 21258 | 14:00:48 INFO - PROCESS | 21258 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43470/tests/dromaeo/cssquery-prototype.html) 14:00:49 INFO - PROCESS | 21258 | RSS: Main: 196567040 14:00:49 INFO - PROCESS | 21258 | 14:03:51 INFO - PROCESS | 21258 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43470/tests/dromaeo/cssquery-yui.html) 14:03:52 INFO - PROCESS | 21258 | RSS: Main: 200478720 14:03:52 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | Cycle 1(1): loaded http://localhost:43470/tests/dromaeo/cssquery-yui.html (next: http://localhost:43470/tests/dromaeo/cssquery-dojo.html) 14:06:55 INFO - PROCESS | 21258 | RSS: Main: 199553024 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | __start_tp_report 14:06:55 INFO - PROCESS | 21258 | _x_x_mozilla_page_load 14:06:55 INFO - PROCESS | 21258 | _x_x_mozilla_page_load_details 14:06:55 INFO - PROCESS | 21258 | |i|pagename|runs| 14:06:55 INFO - PROCESS | 21258 | |0;dojo.html;3072.738817200538;3080.6611272760006;3085.5988721466206;3114.4394009078355;3117.8752849886005;5171.637985341028;5210.791568337271;5402.918956215655;5462.071447853865;5466.562674986001;5244.056069907425;5402.540784033362;5415.350157981038;5507.889842203163;5521.779128834842;4858.271259311096;4894.216925291963;4977.776000080005;4989.675671081386;4994.600431965434;4892.975535122319;4966.205407134859;5030.522100400456;5033.647644664875;5072.061668591323;4819.156647586693;4864.927026094611;4993.275974983643;5030.84907452777;5048.242763585492;4941.752912354404;4960.677555958887;5008.398992120969;5030.949690503085;5094.31226784383;4960.603151747888;4961.652684312099;4963.280324352984;4979.825706100305;5035.54680078791;5196.480351964811;5423.159410291411;5457.5633949283965;5459.262999495057;5472.26124473195;5489.149181876815;5693.516051135658;5715.971420142872;5731.455511726379;5835.824925252249;5819.970900145472;5828.6502809831545;5832.2418085649015;5833.095870140135;5859.29688437386;5427.104527752956;5429.348478182565;5430.972845135749;5432.320959880015;5446.754896029688;5738.942610573924;5789.421057894177;5814.767409303665;5828.475437210672;5857.238558987389;5648.096304591246;5657.321121465368;5665.66006039639;5675.035244008528;5716.371199168088;5749.281339832521;5791.768329266866;5817;5840.561957853178;5841.474267315962;5719.914201286984;5783.884322313615;5797.304323481125;5800.042992906123;5814.389489103668;5815.098659707752;5815.680137592389;5818.709064546756;5835;5844.415558444121;4329.870103896888;4356.106998065389;4454.4654641442585;4468.731876087445;4510.391097201836;3898.1229223424502;3919.118198405336;3944.2111577684577;3954.367301231789;4020.2763502569233;5517.834464966058;5518.889622207614;5530.115181570929;5544.279243698294;5545.085060964976;5615.9157612635845;5823.854403639858;5840.29916410025;5863.560232982543;5869.325027621793;5335.839924802262;5370.946290537045;5419.864503387447;5455.890882182413;5556.416576259516;4980.477049909779;4996.225585034325;4999.275105109811;5002.674826136289;5053.494650534917;5932;5968.432998865101;5977.774556215878;5980.222571065734;5982.970085149546;5643.492085712305;5646.943530564642;5736.856578585569;5759.049756790083;5782.479576838105;6000.69996500182;6013.579049466495;6033.54748393881;6036.366181550874;6057.636541807506;5659.066254068032;5715.371309155907;5721.370649228665;5723.255976723;5729.742161602655;5634.85912852182;5689.487946084872;5706.172604972338;5717;5813.738381772915;5618.85952851182;5661.801836935688;5679.488846003879;5690.430956904276;5729.197912292199;5590.86022849432;5595.356533998643;5599.60802743804;5615.550755939434;5616.522595579421;5485.396606373375;5487.6981766003255;5506.284183056177;5511.366192887869;5518.448155184449;5643;5655.264815573949;5659.377468478547;5680.573956953328;5727.427257274406;5527.391986881359;5527.972360138174;5534.806281780118;5541.085720856014;5555.722213889208 14:06:55 INFO - PROCESS | 21258 | |1;ext.html;560.9242752228448;576.6597707352662;583.7081459270368;586.6157666728294;592.5111782779203;41128.17743645129;42019;42029.369559456594;46101.07797844041;46157.30764038542;42921.57078429215;43122;43268.56731432685;43383.56616433835;43739.3439098413;8487.957560212206;8612.612432440525;8614.827703445928;8616.353773466984;8628.568571571397;8556.443831150986;8607.526586037766;8638.697645582406;8642.092580279075;8656.350773691967;8578.785530361729;8611.698590549331;8701.95649021754;8703.303735701129;8704.086070962552;8586.828263434758;8606.698765543208;8649.783755406133;8669.566521673954;8682.26200772935;8513.148685131498;8533.104024077444;8558.272546833527;8577.05652378238;8587.141285871425;41271.38092928608;41350.79324603388;41535.584644153474;41621;41633.58366416327;3274.279658475132;3396.932061358759;3575.5530558680166;3816.809159542012;3861.903452413684;29907;30076.24809379761;30527.236819079702;30672;31268.530972035438;4250.957490425087;4256.5105012923605;4289.656827453796;4314.654827613784;4329.76186309756;318050;320951;321895.39052304823;322045;322142;53617;53903.46096539063;53992.46007539874;54125.45874541283;54278;55769.442305577235;56321;56340.43659563352;56353.43646563564;56563.43436565664;14674.486392976409;14764.48324308644;14766.48317308889;14807.629809254855;14812.851871481364;11702;11717.296962182296;11738.471768770425;11765.823417658166;11787.587434439925;13494.932525337506;15120.319585618674;15193.240337983056;15308.234588270541;15313.157776322409;6035.366286539938;6505.642189679613;6647.302033286532;6697.732090716317;6707.798766037026;910.4491782471641;955.4028732042474;1057.9259451838298;1059.9476986407544;1089.6022951622601;29402.558961615592;30357.544636830466;30842.63109090342;30952.380952380827;30988.84505577458;1048.8688913885765;1056.7199692081604;1060.9151267898549;1079;1100.49927283086;15368.538943831703;15932.283047262901;15965.760513592306;15978.440754573767;16335.509934701979;478328;478957;481526;485902;486126;53645;53814;54002;54022.45977540253;54316.728416358455;1310.829592153014;1334.7130366971148;1357.83705955286;1358.9184648920898;1360.9659758506116;27605.58591621087;28270.293242668275;29041.854790726757;29427.55858662079;29480.115596532138;46019.539804601525;51161.744191278805;52367.73816130895;52404.47595523996;58187;409066;411303;412893;412923;413326;25986.870065650306;26036.739632603432;26322.605160922983;26341.736582634694;26433.207003789918;44454.55545444634;44566.55433445624;44734.77632611946;45617.54382456133;46228.53771462242;38032;39236.80381598074;39267.60732392639;39485;40773;37461.62538374581;38217.617823821405;38370;39380;39683;38400.80799595984;39198;39336.40995385129;39387.2122557553;41246.38130428106;30777.538336925412;34441.65558344385;34822.30355392928;34985.82507087448;35241.82379088191;26677.402039721157;26994;27085.322866928484;27190.72809271961;27445.31386715348 14:06:55 INFO - PROCESS | 21258 | |2;jquery.html;376.5594254721977;380.76773168367293;389.51699892133763;395.12676983865657;422.5710903433016;18796.436106916797;19284.517887052796;19451.41645750626;19496.610067798636;20211.292604758837;18977.14602842872;19182.32861849832;19225.32711355103;19308.903455482738;19332.4200273992;5503.229547863302;5590.636608620447;5657.179708942201;5728.627639203439;5743.54051675865;5611.7474713637785;5688.857778555549;5689.431056894319;5698.230738850264;5722.685252311121;5435.728213589305;5629.437056294379;5675.233843431146;5675.460831221028;5677.914831277534;5593.300837395325;5677.37548869624;5685.260916080924;5693.544516438675;5733.942660573403;4997.550220480174;5248.343957005374;5278.9208161877605;5319.760610772524;5378.784848606051;13070.411831467607;13285.13646612967;14776.778348324677;21979.450513737123;22190.778092219192;2232.6985856909273;2393.9760602393926;2616.7775739062013;2799.5526283086865;2874.870630821597;9622.326437149402;9715.854262186072;9772.755681107958;10035.247356448222;10213.693589192337;1813.882097663661;1832.0564909071838;1855.8793678410996;1866.915988780508;1883.2843519462517;85312;87265.56367218123;88470.99999999936;90390.54804725935;90426;10470.528826202839;10499.265051446479;10724.820269770318;10977.615783447542;11662.358570278546;14854.731958969225;14872.925635371754;14877.18175500358;14879.628009299855;14884.404623815142;7057.647117644097;7365.563715075509;7470.3276705096805;7528.623568821537;7593.863803239519;6829.146356705412;6831.419329356961;7036;7049.118860142482;7096.538724982963;4510.774461276988;4511.097780443859;4572.45130584332;4630.606398456169;4733.313669517901;1908.9236430542624;1985.4837742187135;1985.8312043476178;1987.6012019446619;1992.4221975627195;863.1842908451453;965.7295957132014;985.7929834734786;995.2585323933715;1015.2284263959444;17636.647267054588;19627.803721962882;19639.60720785605;19666.213351466067;19735;957.6217394129419;961.1925982175006;990.3117333453181;1038.8753349598096;1062.3519653011656;10253;10831.458427078614;10852.294600851077;10911.399873007062;10913.39976301311;462738;467893;476236;477241;480858;83399.58300208581;93250;96014;97792.51103744436;101867.4906625477;1022.7954409118057;1040.1107053469175;1075.5643964194514;1079.5951518180682;1082.0315817343433;17511.562210944317;17690;18342.449726508225;18378.724319134955;18454.81545184531;42773.786131069144;42934.78532607317;43661.12677746491;44778;44813;59531.70234148802;60126.39873601208;61245.38754612575;61675.6916215434;61787.38212617816;8140.267375936194;8144.429889907649;8230.21812927771;8471.32229421657;8489.193526614961;12890.48438062467;12983.870161298644;13037.087403881636;13055.543055992996;13211.207327560378;11545.538178472767;11695.005924496512;11761.47073381717;11918.04655627565;11951.22317049389;11285.266457680225;11322.320660760051;11436.256643318158;11500.079993600659;11824.881751182722;11523.654290371302;11639.243449175776;11649.475773590038;11686.883131168579;12120.393980301125;8090.6359213836695;8215;8222.671093156207;8430.283425908867;8728.127187281221;8581.95709021451;10762.3542587445;11310.886891130984;11316.94341528287;11520.366379849189 14:06:55 INFO - PROCESS | 21258 | |3;mootools.html;1423.7650787620046;1462.5246794791692;1561.4769052367462;1626.406361677988;1687.11426501087;7307.378872795805;7495.775126746193;7891.526508409493;8469.153084691528;8470.491770493774;7971;8220.753377398672;8234.135415781331;8353.791155221123;8431.114732953043;2293.3578597992587;2326.6975293211945;2327.2785436514737;2332.895019724108;2344.1443872986406;2347.7065366829147;2375.0262392419113;2388.2715771689627;2394.604890193125;2421.576224160765;2295.4031951692596;2295.483516208856;2299.977000229993;2324.337563794319;2330.0330362899376;2238.2389987404363;2276.1919518570917;2286.8856557172076;2295.150794206146;2302.3093072078395;2226.332100369899;2228.43174990378;2234.4748983988748;2249.3139592424304;2275.453891066132;8190.467619604707;8294.212049855254;8381.622826972802;8427.747167584983;8431.494110353398;4977.776000080005;5156;5157.252198431244;5158.148905430599;5163.432022477562;3080.738137258336;3109.8911538096286;3367.0908854609365;3398.3033478137168;3406.148462884279;1093.4805967165612;1103.1836441033577;1123.3989815448776;1133.6939026462892;1162.250348525205;11366.488508017159;11386.54453821846;11422.428878556038;11497.367644779533;11500.482478288497;4411.316245981878;4527.909441811145;4731.716097034189;4735.266033764772;4737.59730422911;9495.05049495045;9579.233661307078;9596.520173991272;9620.807583848424;9640.903590964;5153.768080436389;5158.948410515847;5190.325257716549;5193.870153246124;5211.0359583477175;4098.200850834119;4158.793949754598;4569.1547063793305;4668.719876807335;4722.881927951828;3683.318586061587;3772.2266935278203;3830.559485659129;3836.635519625631;3864.401017842239;1196;1239.5289789879969;1240.3736113262744;1265.8923991460645;1282.1345591725549;947.924166066713;966.6133546581283;984.7931934293736;995.7162208770466;998.9361330183332;5676.432356764373;5762.423757624204;5782.161586569924;5804.100364443518;5867.119932010232;393.53366260980255;416.74578507110635;420.60253060857195;420.6403524986154;426.5585119401405;3784.3377408953324;3907.765534067965;3909.6090390961244;3935.9803200984384;4039.939400908989;8992.955035224782;9405.482698451515;9422.057794220524;9425.90574094264;9537.2370210383;9541.332106752461;9566.33035687509;9574.281928855224;9574.617015319309;9583.137517623447;7407.962960185165;7444.367228785505;7536.133344665324;7592.696292148363;7712.074551053797;5686.317641883001;5713.542916566747;5844.444777746107;5908.084246941731;5945.19739835134;8905;8983.505907174907;9054.592543335433;9056.13966673165;9079.68221112258;9021.90978090237;9093.770138025098;9116.680916167903;9146.496942668216;9173.724788256362;6705.2959439258175;6872.347127022925;7163.892541611775;7335.376492998155;7457.552546847207;7646.006019217466;8066.395020373613;8081.555514446762;8085.353171746364;8110;7241.275872412716;7341.632918353954;7509.5869727163345;7514.549127052394;7570.848583028419;7079.610621415665;7190.352868241884;7254.89117663246;7282.927170728225;7318.853622927618;6213.9067913982235;6299.905501417391;6332.430081292706;6337.493000559852;6342.841428964312;4713.882152946204;4876.707397556158;4931.334269873664;4960.627952903475;5023.623228257822;4893.853184404474;4930.704157750546;5012;5047.343845300087;5075.847724568269 14:06:55 INFO - PROCESS | 21258 | |4;prototype.html;317.0188267312667;321.1617677860783;326.49556435307454;339.60436091952874;343.40762185230466;5356.4107948125675;5409.486098820616;5477.6713397196145;5575.804846830361;5585.162225666147;5226.3728352597645;5293.841184764454;5348.839534813952;5390.676559406428;5434.456554344573;4272.636825869805;4285.492986602825;4285.907093691105;4287.31402975524;4296.334068219423;4145.253854306224;4191.2874811282;4220.725652832556;4281.850135245267;4313.223619748444;4191.413202151702;4194.5805419457965;4215.936760948588;4217.536071032184;4222.535521092677;4185.916281674349;4200.222958752625;4216.2832318505625;4231.513375961773;4248.532661407243;3687.46531752897;3763.717721170923;3768.1144930941205;3775.735698501106;3778.0932576181795;5257.291380301379;5273.868153296198;5282.471752824726;5309.362876454811;5338.119210330291;4792.137415265251;4839.080574690797;4852.8544143675745;4853.684510506806;4856.562909338177;5568.081266591048;5648.576356773258;5655.8586035349035;5701.4013528579735;5736.827895163152;4130.215259100762;4133.1940271647045;4134.193832202722;4142.937855932163;4173.561776013536;5866.917244378227;5887.499562537189;5908.97045514774;5964.612300200516;5972.9701351493395;4184.163167366539;4284.207421627009;4305.440292761921;4305.56944305567;4308.46144231971;4215.6205941464805;4244.3209086546;4249.746324834119;4252.48970123581;4290.2706539888295;4832.347633069561;4845.75771211445;4863.076015557032;4883.194272944996;4890.779914903838;5572.3870374258795;5712.34308054579;5730.366845449027;5743.712814359349;5750.951995442422;1463.3488097796378;1474.2849717886816;1480.7704805755125;1481.3852251315798;1490.9552713418398;895.705705255912;938.521828120699;953.1755031897497;954.4607296877242;954.4988880837616;4824.34871292371;4861.7326047067045;4891.73095479752;4899.828506002273;4943.7640589852535;5073.543381095646;5135.512126347991;5171.405288391883;5172.5344718975475;5205.9219111713355;4678.619807156897;4800.279958006257;4856.465788763233;4883.487233840467;4900.387451568554;2791.9581206281923;2803.7897157713255;2808.3119635689386;2817.5351067073702;2825.519661657523;5357.491038351351;5377.27406800077;5404.864878377994;5450.863728406822;5472.5621950243885;5018.623603229772;5096.566791822663;5142.61430392722;5192;5232.581393488512;5169.043726910533;5224.1528367040055;5263.789448422097;5313.734313284321;5328.680279183184;5103.540681338697;5227.503387178212;5239.528442440199;5244.659097158673;5249.7112658804135;4860.810757677001;5018.924716129334;5063.721495317793;5112.948870511247;5127.564157046693;5292.4442933492965;5325.440828712929;5350.545203657733;5351.384590772111;5400.351957765093;3856.8264428101365;4126.627189366187;4233.97883010583;4276.337167739005;4313.115811258747;5873.149957763291;5919.4968427684125;5922.851928701817;5974.564625340534;5982.252218472691;5592.468715472024;5898.761260135419;5909.2908850938165;5911.758530708427;5914.3198532167635;5726.942730572641;5749.252597162509;5761.251037365116;5770.2498675171955;5790.812883358985;5713.542916566582;5744.569157313302;5761.703616686212;5782.884342313046;5796.536277097906;5522.641028333145;5770.586206379296;5773.037167363117;5780.283266864567;5874.765009399747;5728.713564321851;5746.367899531132;5764.913526297193;5768.50967667753;5815.709214539172 14:06:55 INFO - PROCESS | 21258 | |5;yui.html;647.8121344810005;737.5758938610297;744.8212429017034;770.0836005153863;790.0716657926935;14120.293985300732;14140.151590904527;14353.49762758301;14492.420303187873;15019.624509387271;13245.668858278525;13311.800322995163;13465.66335841602;13499.39252733627;13516.32418379082;786.1509569664763;803.9758807235793;809.0857331215718;810.6109067647533;811.5455345006785;785.4305628419379;814.0313027497289;816.8039670479102;824.5423789796661;825.154216927648;850.8298340331959;853.714005808055;855.1448551448551;856.25933567464;858.6951632170583;849.5412477262271;851.0723311590365;851.8977722673256;852.1393392673383;854.6965827131341;619.1023016625866;619.7582942652369;622.3527531367373;622.4708997352215;624.1386886097202;13773.586792396243;14563.854361456462;14655.193964331958;14655.63360915975;14726.631834204123;12921.418536165895;12958.935205323913;13247.271400072992;13477.58485359033;14230.928845355811;11496.597619083292;11532.67374251955;11633.487646605887;11694.239874408137;12323.322217278046;3755.6995440364703;3886.2227554489214;3923.5487918889407;3947.3486874665646;3949.8420063197436;64115.35884641141;66104.3389566103;66330.66834665844;67355.66322168407;67545;10780.622678206226;10795.676129716121;10810.729731756612;10825.945870270756;10996.28524145944;18393;19427.4171774847;19445.611087778165;19495.707564386546;19552.804471955384;7877.487963282369;8309.792255193548;8344.374171937008;8433;8493.235608795238;4566;4640.350350950869;4732.006278681447;4752.619790416758;4800.5199480052415;3302.2734998300334;3322.8172450515453;3336.199312165063;3349.882754103595;3380.797152170878;583.4253260538367;585.3034888482692;587.3157771196509;588.9558283128782;619.4703528483172;675.2007286623652;684.8561802021532;685.1675214614168;693.2651389527017;695.4714417043084;8481.618327175293;8913.643454261886;8926.821463570692;9021.188093071523;9136.451812891248;607.3713706314032;650.7527139686889;729.212450553401;739.7743688175051;775.5269285735696;4257.74453532789;4285.3786201000685;4444.466664000341;4756.548127927841;4875.975620121877;48046.27930581044;69947.65026174836;78139;78230.6088469554;83816.58091709625;44977.77511112489;60668;67848;71046.289537105;72278.63860680768;64747.67626161839;65717;65894.67052664707;65906.67046664737;66444.33555664479;8888.200061994452;9071.319651026331;9093.499857507635;9109.954450227706;9151.313651476034;43848.56151438572;43979.34030989474;45032.77483612692;45081.774591126836;46164;56521.43478565326;59819.40180598312;60588.62314931304;62223;63553.364466356594;10554.10290125348;10589.735256618646;10624.681259562225;10722.303050301705;11562.075033997427;12418.441170147184;12585.24488530691;12621.621351359474;12705.936470317589;12871;11219.270747401393;11401.885981140415;11506.654800356002;11600.477978491157;12165.939170304091;11135.276207046516;11225.71935701614;11440.141989350666;11479.540818367172;12036.518539258332;10658.200634952565;10671.092957098423;10933.671989840317;11067.612633558108;11300.830487542858;9156.771080723036;9763.463009534544;9833.459159746282;9865.654702085392;9957;8409;9290.58192381358;9405.764855878384;10157.18742500613;10232.539535720762 14:06:55 INFO - PROCESS | 21258 | __end_tp_report 14:06:55 INFO - PROCESS | 21258 | __start_cc_report 14:06:55 INFO - PROCESS | 21258 | _x_x_mozilla_cycle_collect,331 14:06:55 INFO - PROCESS | 21258 | __end_cc_report 14:06:55 INFO - PROCESS | 21258 | __startTimestamp1477948015453__endTimestamp 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | ------- Summary: start ------- 14:06:55 INFO - PROCESS | 21258 | Number of tests: 6 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | [#0] dojo.html Cycles:165 Average:5371.44 Median:5544.28 stddev:603.35 (10.9%) stddev-sans-first:577.62 14:06:55 INFO - PROCESS | 21258 | Values: 3072.7 3080.7 3085.6 3114.4 3117.9 5171.6 5210.8 5402.9 5462.1 5466.6 5244.1 5402.5 5415.4 5507.9 5521.8 4858.3 4894.2 4977.8 4989.7 4994.6 4893.0 4966.2 5030.5 5033.6 5072.1 4819.2 4864.9 4993.3 5030.8 5048.2 4941.8 4960.7 5008.4 5030.9 5094.3 4960.6 4961.7 4963.3 4979.8 5035.5 5196.5 5423.2 5457.6 5459.3 5472.3 5489.1 5693.5 5716.0 5731.5 5835.8 5820.0 5828.7 5832.2 5833.1 5859.3 5427.1 5429.3 5431.0 5432.3 5446.8 5738.9 5789.4 5814.8 5828.5 5857.2 5648.1 5657.3 5665.7 5675.0 5716.4 5749.3 5791.8 5817.0 5840.6 5841.5 5719.9 5783.9 5797.3 5800.0 5814.4 5815.1 5815.7 5818.7 5835.0 5844.4 4329.9 4356.1 4454.5 4468.7 4510.4 3898.1 3919.1 3944.2 3954.4 4020.3 5517.8 5518.9 5530.1 5544.3 5545.1 5615.9 5823.9 5840.3 5863.6 5869.3 5335.8 5370.9 5419.9 5455.9 5556.4 4980.5 4996.2 4999.3 5002.7 5053.5 5932.0 5968.4 5977.8 5980.2 5983.0 5643.5 5646.9 5736.9 5759.0 5782.5 6000.7 6013.6 6033.5 6036.4 6057.6 5659.1 5715.4 5721.4 5723.3 5729.7 5634.9 5689.5 5706.2 5717.0 5813.7 5618.9 5661.8 5679.5 5690.4 5729.2 5590.9 5595.4 5599.6 5615.6 5616.5 5485.4 5487.7 5506.3 5511.4 5518.4 5643.0 5655.3 5659.4 5680.6 5727.4 5527.4 5528.0 5534.8 5541.1 5555.7 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | [#1] ext.html Cycles:180 Average:56058.21 Median:41258.88 stddev:108633.52 (263.3%) stddev-sans-first:108858.36 14:06:55 INFO - PROCESS | 21258 | Values: 560.9 576.7 583.7 586.6 592.5 41128.2 42019.0 42029.4 46101.1 46157.3 42921.6 43122.0 43268.6 43383.6 43739.3 8488.0 8612.6 8614.8 8616.4 8628.6 8556.4 8607.5 8638.7 8642.1 8656.4 8578.8 8611.7 8702.0 8703.3 8704.1 8586.8 8606.7 8649.8 8669.6 8682.3 8513.1 8533.1 8558.3 8577.1 8587.1 41271.4 41350.8 41535.6 41621.0 41633.6 3274.3 3396.9 3575.6 3816.8 3861.9 29907.0 30076.2 30527.2 30672.0 31268.5 4251.0 4256.5 4289.7 4314.7 4329.8 318050.0 320951.0 321895.4 322045.0 322142.0 53617.0 53903.5 53992.5 54125.5 54278.0 55769.4 56321.0 56340.4 56353.4 56563.4 14674.5 14764.5 14766.5 14807.6 14812.9 11702.0 11717.3 11738.5 11765.8 11787.6 13494.9 15120.3 15193.2 15308.2 15313.2 6035.4 6505.6 6647.3 6697.7 6707.8 910.4 955.4 1057.9 1059.9 1089.6 29402.6 30357.5 30842.6 30952.4 30988.8 1048.9 1056.7 1060.9 1079.0 1100.5 15368.5 15932.3 15965.8 15978.4 16335.5 478328.0 478957.0 481526.0 485902.0 486126.0 53645.0 53814.0 54002.0 54022.5 54316.7 1310.8 1334.7 1357.8 1358.9 1361.0 27605.6 28270.3 29041.9 29427.6 29480.1 46019.5 51161.7 52367.7 52404.5 58187.0 409066.0 411303.0 412893.0 412923.0 413326.0 25986.9 26036.7 26322.6 26341.7 26433.2 44454.6 44566.6 44734.8 45617.5 46228.5 38032.0 39236.8 39267.6 39485.0 40773.0 37461.6 38217.6 38370.0 39380.0 39683.0 38400.8 39198.0 39336.4 39387.2 41246.4 30777.5 34441.7 34822.3 34985.8 35241.8 26677.4 26994.0 27085.3 27190.7 27445.3 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | [#2] jquery.html Cycles:180 Average:28664.07 Median:378.66 stddev:78396.02 (20703.3%) stddev-sans-first:78587.17 14:06:55 INFO - PROCESS | 21258 | Values: 376.6 380.8 389.5 395.1 422.6 18796.4 19284.5 19451.4 19496.6 20211.3 18977.1 19182.3 19225.3 19308.9 19332.4 5503.2 5590.6 5657.2 5728.6 5743.5 5611.7 5688.9 5689.4 5698.2 5722.7 5435.7 5629.4 5675.2 5675.5 5677.9 5593.3 5677.4 5685.3 5693.5 5733.9 4997.6 5248.3 5278.9 5319.8 5378.8 13070.4 13285.1 14776.8 21979.5 22190.8 2232.7 2394.0 2616.8 2799.6 2874.9 9622.3 9715.9 9772.8 10035.2 10213.7 1813.9 1832.1 1855.9 1866.9 1883.3 85312.0 87265.6 88471.0 90390.5 90426.0 10470.5 10499.3 10724.8 10977.6 11662.4 14854.7 14872.9 14877.2 14879.6 14884.4 7057.6 7365.6 7470.3 7528.6 7593.9 6829.1 6831.4 7036.0 7049.1 7096.5 4510.8 4511.1 4572.5 4630.6 4733.3 1908.9 1985.5 1985.8 1987.6 1992.4 863.2 965.7 985.8 995.3 1015.2 17636.6 19627.8 19639.6 19666.2 19735.0 957.6 961.2 990.3 1038.9 1062.4 10253.0 10831.5 10852.3 10911.4 10913.4 462738.0 467893.0 476236.0 477241.0 480858.0 83399.6 93250.0 96014.0 97792.5 101867.5 1022.8 1040.1 1075.6 1079.6 1082.0 17511.6 17690.0 18342.4 18378.7 18454.8 42773.8 42934.8 43661.1 44778.0 44813.0 59531.7 60126.4 61245.4 61675.7 61787.4 8140.3 8144.4 8230.2 8471.3 8489.2 12890.5 12983.9 13037.1 13055.5 13211.2 11545.5 11695.0 11761.5 11918.0 11951.2 11285.3 11322.3 11436.3 11500.1 11824.9 11523.7 11639.2 11649.5 11686.9 12120.4 8090.6 8215.0 8222.7 8430.3 8728.1 8582.0 10762.4 11310.9 11316.9 11520.4 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | [#3] mootools.html Cycles:180 Average:5414.04 Median:5161.19 stddev:2963.11 (57.4%) stddev-sans-first:2956.24 14:06:55 INFO - PROCESS | 21258 | Values: 1423.8 1462.5 1561.5 1626.4 1687.1 7307.4 7495.8 7891.5 8469.2 8470.5 7971.0 8220.8 8234.1 8353.8 8431.1 2293.4 2326.7 2327.3 2332.9 2344.1 2347.7 2375.0 2388.3 2394.6 2421.6 2295.4 2295.5 2300.0 2324.3 2330.0 2238.2 2276.2 2286.9 2295.2 2302.3 2226.3 2228.4 2234.5 2249.3 2275.5 8190.5 8294.2 8381.6 8427.7 8431.5 4977.8 5156.0 5157.3 5158.1 5163.4 3080.7 3109.9 3367.1 3398.3 3406.1 1093.5 1103.2 1123.4 1133.7 1162.3 11366.5 11386.5 11422.4 11497.4 11500.5 4411.3 4527.9 4731.7 4735.3 4737.6 9495.1 9579.2 9596.5 9620.8 9640.9 5153.8 5158.9 5190.3 5193.9 5211.0 4098.2 4158.8 4569.2 4668.7 4722.9 3683.3 3772.2 3830.6 3836.6 3864.4 1196.0 1239.5 1240.4 1265.9 1282.1 947.9 966.6 984.8 995.7 998.9 5676.4 5762.4 5782.2 5804.1 5867.1 393.5 416.7 420.6 420.6 426.6 3784.3 3907.8 3909.6 3936.0 4039.9 8993.0 9405.5 9422.1 9425.9 9537.2 9541.3 9566.3 9574.3 9574.6 9583.1 7408.0 7444.4 7536.1 7592.7 7712.1 5686.3 5713.5 5844.4 5908.1 5945.2 8905.0 8983.5 9054.6 9056.1 9079.7 9021.9 9093.8 9116.7 9146.5 9173.7 6705.3 6872.3 7163.9 7335.4 7457.6 7646.0 8066.4 8081.6 8085.4 8110.0 7241.3 7341.6 7509.6 7514.5 7570.8 7079.6 7190.4 7254.9 7282.9 7318.9 6213.9 6299.9 6332.4 6337.5 6342.8 4713.9 4876.7 4931.3 4960.6 5023.6 4893.9 4930.7 5012.0 5047.3 5075.8 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | [#4] prototype.html Cycles:180 Average:4645.93 Median:5155.83 stddev:1338.73 (26.0%) stddev-sans-first:1302.46 14:06:55 INFO - PROCESS | 21258 | Values: 317.0 321.2 326.5 339.6 343.4 5356.4 5409.5 5477.7 5575.8 5585.2 5226.4 5293.8 5348.8 5390.7 5434.5 4272.6 4285.5 4285.9 4287.3 4296.3 4145.3 4191.3 4220.7 4281.9 4313.2 4191.4 4194.6 4215.9 4217.5 4222.5 4185.9 4200.2 4216.3 4231.5 4248.5 3687.5 3763.7 3768.1 3775.7 3778.1 5257.3 5273.9 5282.5 5309.4 5338.1 4792.1 4839.1 4852.9 4853.7 4856.6 5568.1 5648.6 5655.9 5701.4 5736.8 4130.2 4133.2 4134.2 4142.9 4173.6 5866.9 5887.5 5909.0 5964.6 5973.0 4184.2 4284.2 4305.4 4305.6 4308.5 4215.6 4244.3 4249.7 4252.5 4290.3 4832.3 4845.8 4863.1 4883.2 4890.8 5572.4 5712.3 5730.4 5743.7 5751.0 1463.3 1474.3 1480.8 1481.4 1491.0 895.7 938.5 953.2 954.5 954.5 4824.3 4861.7 4891.7 4899.8 4943.8 5073.5 5135.5 5171.4 5172.5 5205.9 4678.6 4800.3 4856.5 4883.5 4900.4 2792.0 2803.8 2808.3 2817.5 2825.5 5357.5 5377.3 5404.9 5450.9 5472.6 5018.6 5096.6 5142.6 5192.0 5232.6 5169.0 5224.2 5263.8 5313.7 5328.7 5103.5 5227.5 5239.5 5244.7 5249.7 4860.8 5018.9 5063.7 5112.9 5127.6 5292.4 5325.4 5350.5 5351.4 5400.4 3856.8 4126.6 4234.0 4276.3 4313.1 5873.1 5919.5 5922.9 5974.6 5982.3 5592.5 5898.8 5909.3 5911.8 5914.3 5726.9 5749.3 5761.3 5770.2 5790.8 5713.5 5744.6 5761.7 5782.9 5796.5 5522.6 5770.6 5773.0 5780.3 5874.8 5728.7 5746.4 5764.9 5768.5 5815.7 14:06:55 INFO - PROCESS | 21258 | 14:06:55 INFO - PROCESS | 21258 | [#5] yui.html Cycles:180 Average:16553.11 Median:584.36 stddev:21465.24 (3673.3%) stddev-sans-first:21492.23 14:06:55 INFO - PROCESS | 21258 | Values: 647.8 737.6 744.8 770.1 790.1 14120.3 14140.2 14353.5 14492.4 15019.6 13245.7 13311.8 13465.7 13499.4 13516.3 786.2 804.0 809.1 810.6 811.5 785.4 814.0 816.8 824.5 825.2 850.8 853.7 855.1 856.3 858.7 849.5 851.1 851.9 852.1 854.7 619.1 619.8 622.4 622.5 624.1 13773.6 14563.9 14655.2 14655.6 14726.6 12921.4 12958.9 13247.3 13477.6 14230.9 11496.6 11532.7 11633.5 11694.2 12323.3 3755.7 3886.2 3923.5 3947.3 3949.8 64115.4 66104.3 66330.7 67355.7 67545.0 10780.6 10795.7 10810.7 10825.9 10996.3 18393.0 19427.4 19445.6 19495.7 19552.8 7877.5 8309.8 8344.4 8433.0 8493.2 4566.0 4640.4 4732.0 4752.6 4800.5 3302.3 3322.8 3336.2 3349.9 3380.8 583.4 585.3 587.3 589.0 619.5 675.2 684.9 685.2 693.3 695.5 8481.6 8913.6 8926.8 9021.2 9136.5 607.4 650.8 729.2 739.8 775.5 4257.7 4285.4 4444.5 4756.5 4876.0 48046.3 69947.7 78139.0 78230.6 83816.6 44977.8 60668.0 67848.0 71046.3 72278.6 64747.7 65717.0 65894.7 65906.7 66444.3 8888.2 9071.3 9093.5 9110.0 9151.3 43848.6 43979.3 45032.8 45081.8 46164.0 56521.4 59819.4 60588.6 62223.0 63553.4 10554.1 10589.7 10624.7 10722.3 11562.1 12418.4 12585.2 12621.6 12705.9 12871.0 11219.3 11401.9 11506.7 11600.5 12165.9 11135.3 11225.7 11440.1 11479.5 12036.5 10658.2 10671.1 10933.7 11067.6 11300.8 9156.8 9763.5 9833.5 9865.7 9957.0 8409.0 9290.6 9405.8 10157.2 10232.5 14:06:55 INFO - PROCESS | 21258 | -------- Summary: end -------- 14:06:55 INFO - PROCESS | 21258 | 14:06:56 INFO - TEST-INFO | 21258: exit 0 14:06:56 INFO - TEST-OK | dromaeo_css | took 1115575ms 14:06:56 INFO - TEST-START | kraken 14:06:56 INFO - operating with platform_type : linux_ 14:06:56 INFO - Initialising browser for kraken test... 14:06:56 INFO - TEST-INFO | started process 21606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_phGdl/profile http://localhost:43470/getInfo.html) 14:07:00 INFO - PROCESS | 21606 | __metrics Screen width/height:1600/1200 14:07:00 INFO - PROCESS | 21606 | colorDepth:24 14:07:00 INFO - PROCESS | 21606 | Browser inner width/height: 1024/697 14:07:00 INFO - PROCESS | 21606 | __metrics 14:07:01 ERROR - PROCESS | 21606 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 14:07:02 INFO - TEST-INFO | 21606: exit 0 14:07:02 INFO - Browser initialized. 14:07:02 INFO - Running cycle 1/1 for kraken test... 14:07:02 INFO - TEST-INFO | started process 21728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_phGdl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:14 INFO - PROCESS | 21728 | RSS: Main: 186990592 14:07:14 INFO - PROCESS | 21728 | 14:07:17 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-beat-detection) 14:07:18 INFO - PROCESS | 21728 | RSS: Main: 199786496 14:07:18 INFO - PROCESS | 21728 | 14:07:21 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-dft) 14:07:21 INFO - PROCESS | 21728 | RSS: Main: 197996544 14:07:21 INFO - PROCESS | 21728 | 14:07:24 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-fft) 14:07:25 INFO - PROCESS | 21728 | RSS: Main: 193974272 14:07:25 INFO - PROCESS | 21728 | 14:07:27 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43470/tests/kraken/driver.html?testName=audio-oscillator) 14:07:27 INFO - PROCESS | 21728 | RSS: Main: 194543616 14:07:27 INFO - PROCESS | 21728 | 14:07:30 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43470/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:07:30 INFO - PROCESS | 21728 | RSS: Main: 195092480 14:07:30 INFO - PROCESS | 21728 | 14:07:33 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43470/tests/kraken/driver.html?testName=imaging-darkroom) 14:07:34 INFO - PROCESS | 21728 | RSS: Main: 195321856 14:07:34 INFO - PROCESS | 21728 | 14:07:37 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43470/tests/kraken/driver.html?testName=imaging-desaturate) 14:07:38 INFO - PROCESS | 21728 | RSS: Main: 195158016 14:07:38 INFO - PROCESS | 21728 | 14:07:41 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43470/tests/kraken/driver.html?testName=json-parse-financial) 14:07:41 INFO - PROCESS | 21728 | RSS: Main: 195543040 14:07:41 INFO - PROCESS | 21728 | 14:07:43 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43470/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:07:44 INFO - PROCESS | 21728 | RSS: Main: 195256320 14:07:44 INFO - PROCESS | 21728 | 14:07:45 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:07:46 INFO - PROCESS | 21728 | RSS: Main: 195186688 14:07:46 INFO - PROCESS | 21728 | 14:07:48 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:07:49 INFO - PROCESS | 21728 | RSS: Main: 195817472 14:07:49 INFO - PROCESS | 21728 | 14:07:51 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:07:52 INFO - PROCESS | 21728 | RSS: Main: 195584000 14:07:52 INFO - PROCESS | 21728 | 14:07:55 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:07:56 INFO - PROCESS | 21728 | RSS: Main: 196022272 14:07:56 INFO - PROCESS | 21728 | 14:07:57 INFO - PROCESS | 21728 | Cycle 1(1): loaded http://localhost:43470/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43470/tests/kraken/driver.html?testName=ai-astar) 14:07:58 INFO - PROCESS | 21728 | RSS: Main: 197152768 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | __start_tp_report 14:07:58 INFO - PROCESS | 21728 | _x_x_mozilla_page_load 14:07:58 INFO - PROCESS | 21728 | _x_x_mozilla_page_load_details 14:07:58 INFO - PROCESS | 21728 | |i|pagename|runs| 14:07:58 INFO - PROCESS | 21728 | |0;ai-astar;107;113;111;111;111;111;111;112;115;112 14:07:58 INFO - PROCESS | 21728 | |1;audio-beat-detection;154;123;124;167;129;124;124;126;158;124 14:07:58 INFO - PROCESS | 21728 | |2;audio-dft;165;164;166;171;163;161;163;166;164;161 14:07:58 INFO - PROCESS | 21728 | |3;audio-fft;75;75;77;111;77;76;76;75;114;77 14:07:58 INFO - PROCESS | 21728 | |4;audio-oscillator;83;82;109;82;83;83;106;81;83;113 14:07:58 INFO - PROCESS | 21728 | |5;imaging-gaussian-blur;117;118;117;117;118;117;118;118;117;117 14:07:58 INFO - PROCESS | 21728 | |6;imaging-darkroom;147;147;148;148;147;147;146;147;147;147 14:07:58 INFO - PROCESS | 21728 | |7;imaging-desaturate;86;86;85;86;85;85;85;86;85;85 14:07:58 INFO - PROCESS | 21728 | |8;json-parse-financial;57;56;54;54;56;56;55;54;54;54 14:07:58 INFO - PROCESS | 21728 | |9;json-stringify-tinderbox;61;61;60;61;61;61;60;61;61;62 14:07:58 INFO - PROCESS | 21728 | |10;stanford-crypto-aes;80;81;86;80;79;82;80;85;88;79 14:07:58 INFO - PROCESS | 21728 | |11;stanford-crypto-ccm;148;136;133;135;133;138;128;138;182;128 14:07:58 INFO - PROCESS | 21728 | |12;stanford-crypto-pbkdf2;170;170;165;165;170;168;169;164;165;170 14:07:58 INFO - PROCESS | 21728 | |13;stanford-crypto-sha256-iterative;63;71;66;63;66;63;65;62;67;63 14:07:58 INFO - PROCESS | 21728 | __end_tp_report 14:07:58 INFO - PROCESS | 21728 | __start_cc_report 14:07:58 INFO - PROCESS | 21728 | _x_x_mozilla_cycle_collect,862 14:07:58 INFO - PROCESS | 21728 | __end_cc_report 14:07:58 INFO - PROCESS | 21728 | __startTimestamp1477948078009__endTimestamp 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | ------- Summary: start ------- 14:07:58 INFO - PROCESS | 21728 | Number of tests: 14 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.50 stddev:2.01 (1.8%) stddev-sans-first:1.36 14:07:58 INFO - PROCESS | 21728 | Values: 107.0 113.0 111.0 111.0 111.0 111.0 111.0 112.0 115.0 112.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:127.50 stddev:17.19 (13.5%) stddev-sans-first:16.84 14:07:58 INFO - PROCESS | 21728 | Values: 154.0 123.0 124.0 167.0 129.0 124.0 124.0 126.0 158.0 124.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:2.91 (1.8%) stddev-sans-first:3.08 14:07:58 INFO - PROCESS | 21728 | Values: 165.0 164.0 166.0 171.0 163.0 161.0 163.0 166.0 164.0 161.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.43 (20.3%) stddev-sans-first:16.07 14:07:58 INFO - PROCESS | 21728 | Values: 75.0 75.0 77.0 111.0 77.0 76.0 76.0 75.0 114.0 77.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:82.50 stddev:13.12 (15.9%) stddev-sans-first:13.63 14:07:58 INFO - PROCESS | 21728 | Values: 83.0 82.0 109.0 82.0 83.0 83.0 106.0 81.0 83.0 113.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 14:07:58 INFO - PROCESS | 21728 | Values: 117.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 117.0 117.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 14:07:58 INFO - PROCESS | 21728 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 146.0 147.0 147.0 147.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 14:07:58 INFO - PROCESS | 21728 | Values: 86.0 86.0 85.0 86.0 85.0 85.0 85.0 86.0 85.0 85.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.15 (2.1%) stddev-sans-first:0.97 14:07:58 INFO - PROCESS | 21728 | Values: 57.0 56.0 54.0 54.0 56.0 56.0 55.0 54.0 54.0 54.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 14:07:58 INFO - PROCESS | 21728 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 61.0 62.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:81.50 stddev:3.20 (3.9%) stddev-sans-first:3.31 14:07:58 INFO - PROCESS | 21728 | Values: 80.0 81.0 86.0 80.0 79.0 82.0 80.0 85.0 88.0 79.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:137.00 stddev:15.86 (11.6%) stddev-sans-first:16.55 14:07:58 INFO - PROCESS | 21728 | Values: 148.0 136.0 133.0 135.0 133.0 138.0 128.0 138.0 182.0 128.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:169.50 stddev:2.55 (1.5%) stddev-sans-first:2.55 14:07:58 INFO - PROCESS | 21728 | Values: 170.0 170.0 165.0 165.0 170.0 168.0 169.0 164.0 165.0 170.0 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.50 stddev:2.73 (4.2%) stddev-sans-first:2.80 14:07:58 INFO - PROCESS | 21728 | Values: 63.0 71.0 66.0 63.0 66.0 63.0 65.0 62.0 67.0 63.0 14:07:58 INFO - PROCESS | 21728 | -------- Summary: end -------- 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | 14:07:58 INFO - PROCESS | 21728 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 14:07:58 INFO - PROCESS | 21728 | 14:07:59 INFO - TEST-INFO | 21728: exit 0 14:07:59 INFO - TEST-OK | kraken | took 62722ms 14:07:59 INFO - SUITE-END | took 1178s 14:07:59 INFO - Completed test suite (00:19:38) 14:07:59 INFO - javascript benchmark 14:07:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6972.135632362975, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3072.738817200538, 3080.6611272760006, 3085.5988721466206, 3114.4394009078355, 3117.8752849886005, 5171.637985341028, 5210.791568337271, 5402.918956215655, 5462.071447853865, 5466.562674986001, 5244.056069907425, 5402.540784033362, 5415.350157981038, 5507.889842203163, 5521.779128834842, 4858.271259311096, 4894.216925291963, 4977.776000080005, 4989.675671081386, 4994.600431965434, 4892.975535122319, 4966.205407134859, 5030.522100400456, 5033.647644664875, 5072.061668591323, 4819.156647586693, 4864.927026094611, 4993.275974983643, 5030.84907452777, 5048.242763585492, 4941.752912354404, 4960.677555958887, 5008.398992120969, 5030.949690503085, 5094.31226784383, 4960.603151747888, 4961.652684312099, 4963.280324352984, 4979.825706100305, 5035.54680078791, 5196.480351964811, 5423.159410291411, 5457.5633949283965, 5459.262999495057, 5472.26124473195, 5489.149181876815, 5693.516051135658, 5715.971420142872, 5731.455511726379, 5835.824925252249, 5819.970900145472, 5828.6502809831545, 5832.2418085649015, 5833.095870140135, 5859.29688437386, 5427.104527752956, 5429.348478182565, 5430.972845135749, 5432.320959880015, 5446.754896029688, 5738.942610573924, 5789.421057894177, 5814.767409303665, 5828.475437210672, 5857.238558987389, 5648.096304591246, 5657.321121465368, 5665.66006039639, 5675.035244008528, 5716.371199168088, 5749.281339832521, 5791.768329266866, 5817.0, 5840.561957853178, 5841.474267315962, 5719.914201286984, 5783.884322313615, 5797.304323481125, 5800.042992906123, 5814.389489103668, 5815.098659707752, 5815.680137592389, 5818.709064546756, 5835.0, 5844.415558444121, 4329.870103896888, 4356.106998065389, 4454.4654641442585, 4468.731876087445, 4510.391097201836, 3898.1229223424502, 3919.118198405336, 3944.2111577684577, 3954.367301231789, 4020.2763502569233, 5517.834464966058, 5518.889622207614, 5530.115181570929, 5544.279243698294, 5545.085060964976, 5615.9157612635845, 5823.854403639858, 5840.29916410025, 5863.560232982543, 5869.325027621793, 5335.839924802262, 5370.946290537045, 5419.864503387447, 5455.890882182413, 5556.416576259516, 4980.477049909779, 4996.225585034325, 4999.275105109811, 5002.674826136289, 5053.494650534917, 5932.0, 5968.432998865101, 5977.774556215878, 5980.222571065734, 5982.970085149546, 5643.492085712305, 5646.943530564642, 5736.856578585569, 5759.049756790083, 5782.479576838105, 6000.69996500182, 6013.579049466495, 6033.54748393881, 6036.366181550874, 6057.636541807506, 5659.066254068032, 5715.371309155907, 5721.370649228665, 5723.255976723, 5729.742161602655, 5634.85912852182, 5689.487946084872, 5706.172604972338, 5717.0, 5813.738381772915, 5618.85952851182, 5661.801836935688, 5679.488846003879, 5690.430956904276, 5729.197912292199, 5590.86022849432, 5595.356533998643, 5599.60802743804, 5615.550755939434, 5616.522595579421, 5485.396606373375, 5487.6981766003255, 5506.284183056177, 5511.366192887869, 5518.448155184449, 5643.0, 5655.264815573949, 5659.377468478547, 5680.573956953328, 5727.427257274406, 5527.391986881359, 5527.972360138174, 5534.806281780118, 5541.085720856014, 5555.722213889208], "value": 5330.7539766863365, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.9242752228448, 576.6597707352662, 583.7081459270368, 586.6157666728294, 592.5111782779203, 41128.17743645129, 42019.0, 42029.369559456594, 46101.07797844041, 46157.30764038542, 42921.57078429215, 43122.0, 43268.56731432685, 43383.56616433835, 43739.3439098413, 8487.957560212206, 8612.612432440525, 8614.827703445928, 8616.353773466984, 8628.568571571397, 8556.443831150986, 8607.526586037766, 8638.697645582406, 8642.092580279075, 8656.350773691967, 8578.785530361729, 8611.698590549331, 8701.95649021754, 8703.303735701129, 8704.086070962552, 8586.828263434758, 8606.698765543208, 8649.783755406133, 8669.566521673954, 8682.26200772935, 8513.148685131498, 8533.104024077444, 8558.272546833527, 8577.05652378238, 8587.141285871425, 41271.38092928608, 41350.79324603388, 41535.584644153474, 41621.0, 41633.58366416327, 3274.279658475132, 3396.932061358759, 3575.5530558680166, 3816.809159542012, 3861.903452413684, 29907.0, 30076.24809379761, 30527.236819079702, 30672.0, 31268.530972035438, 4250.957490425087, 4256.5105012923605, 4289.656827453796, 4314.654827613784, 4329.76186309756, 318050.0, 320951.0, 321895.39052304823, 322045.0, 322142.0, 53617.0, 53903.46096539063, 53992.46007539874, 54125.45874541283, 54278.0, 55769.442305577235, 56321.0, 56340.43659563352, 56353.43646563564, 56563.43436565664, 14674.486392976409, 14764.48324308644, 14766.48317308889, 14807.629809254855, 14812.851871481364, 11702.0, 11717.296962182296, 11738.471768770425, 11765.823417658166, 11787.587434439925, 13494.932525337506, 15120.319585618674, 15193.240337983056, 15308.234588270541, 15313.157776322409, 6035.366286539938, 6505.642189679613, 6647.302033286532, 6697.732090716317, 6707.798766037026, 910.4491782471641, 955.4028732042474, 1057.9259451838298, 1059.9476986407544, 1089.6022951622601, 29402.558961615592, 30357.544636830466, 30842.63109090342, 30952.380952380827, 30988.84505577458, 1048.8688913885765, 1056.7199692081604, 1060.9151267898549, 1079.0, 1100.49927283086, 15368.538943831703, 15932.283047262901, 15965.760513592306, 15978.440754573767, 16335.509934701979, 478328.0, 478957.0, 481526.0, 485902.0, 486126.0, 53645.0, 53814.0, 54002.0, 54022.45977540253, 54316.728416358455, 1310.829592153014, 1334.7130366971148, 1357.83705955286, 1358.9184648920898, 1360.9659758506116, 27605.58591621087, 28270.293242668275, 29041.854790726757, 29427.55858662079, 29480.115596532138, 46019.539804601525, 51161.744191278805, 52367.73816130895, 52404.47595523996, 58187.0, 409066.0, 411303.0, 412893.0, 412923.0, 413326.0, 25986.870065650306, 26036.739632603432, 26322.605160922983, 26341.736582634694, 26433.207003789918, 44454.55545444634, 44566.55433445624, 44734.77632611946, 45617.54382456133, 46228.53771462242, 38032.0, 39236.80381598074, 39267.60732392639, 39485.0, 40773.0, 37461.62538374581, 38217.617823821405, 38370.0, 39380.0, 39683.0, 38400.80799595984, 39198.0, 39336.40995385129, 39387.2122557553, 41246.38130428106, 30777.538336925412, 34441.65558344385, 34822.30355392928, 34985.82507087448, 35241.82379088191, 26677.402039721157, 26994.0, 27085.322866928484, 27190.72809271961, 27445.31386715348], "value": 19068.789374461656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.5594254721977, 380.76773168367293, 389.51699892133763, 395.12676983865657, 422.5710903433016, 18796.436106916797, 19284.517887052796, 19451.41645750626, 19496.610067798636, 20211.292604758837, 18977.14602842872, 19182.32861849832, 19225.32711355103, 19308.903455482738, 19332.4200273992, 5503.229547863302, 5590.636608620447, 5657.179708942201, 5728.627639203439, 5743.54051675865, 5611.7474713637785, 5688.857778555549, 5689.431056894319, 5698.230738850264, 5722.685252311121, 5435.728213589305, 5629.437056294379, 5675.233843431146, 5675.460831221028, 5677.914831277534, 5593.300837395325, 5677.37548869624, 5685.260916080924, 5693.544516438675, 5733.942660573403, 4997.550220480174, 5248.343957005374, 5278.9208161877605, 5319.760610772524, 5378.784848606051, 13070.411831467607, 13285.13646612967, 14776.778348324677, 21979.450513737123, 22190.778092219192, 2232.6985856909273, 2393.9760602393926, 2616.7775739062013, 2799.5526283086865, 2874.870630821597, 9622.326437149402, 9715.854262186072, 9772.755681107958, 10035.247356448222, 10213.693589192337, 1813.882097663661, 1832.0564909071838, 1855.8793678410996, 1866.915988780508, 1883.2843519462517, 85312.0, 87265.56367218123, 88470.99999999936, 90390.54804725935, 90426.0, 10470.528826202839, 10499.265051446479, 10724.820269770318, 10977.615783447542, 11662.358570278546, 14854.731958969225, 14872.925635371754, 14877.18175500358, 14879.628009299855, 14884.404623815142, 7057.647117644097, 7365.563715075509, 7470.3276705096805, 7528.623568821537, 7593.863803239519, 6829.146356705412, 6831.419329356961, 7036.0, 7049.118860142482, 7096.538724982963, 4510.774461276988, 4511.097780443859, 4572.45130584332, 4630.606398456169, 4733.313669517901, 1908.9236430542624, 1985.4837742187135, 1985.8312043476178, 1987.6012019446619, 1992.4221975627195, 863.1842908451453, 965.7295957132014, 985.7929834734786, 995.2585323933715, 1015.2284263959444, 17636.647267054588, 19627.803721962882, 19639.60720785605, 19666.213351466067, 19735.0, 957.6217394129419, 961.1925982175006, 990.3117333453181, 1038.8753349598096, 1062.3519653011656, 10253.0, 10831.458427078614, 10852.294600851077, 10911.399873007062, 10913.39976301311, 462738.0, 467893.0, 476236.0, 477241.0, 480858.0, 83399.58300208581, 93250.0, 96014.0, 97792.51103744436, 101867.4906625477, 1022.7954409118057, 1040.1107053469175, 1075.5643964194514, 1079.5951518180682, 1082.0315817343433, 17511.562210944317, 17690.0, 18342.449726508225, 18378.724319134955, 18454.81545184531, 42773.786131069144, 42934.78532607317, 43661.12677746491, 44778.0, 44813.0, 59531.70234148802, 60126.39873601208, 61245.38754612575, 61675.6916215434, 61787.38212617816, 8140.267375936194, 8144.429889907649, 8230.21812927771, 8471.32229421657, 8489.193526614961, 12890.48438062467, 12983.870161298644, 13037.087403881636, 13055.543055992996, 13211.207327560378, 11545.538178472767, 11695.005924496512, 11761.47073381717, 11918.04655627565, 11951.22317049389, 11285.266457680225, 11322.320660760051, 11436.256643318158, 11500.079993600659, 11824.881751182722, 11523.654290371302, 11639.243449175776, 11649.475773590038, 11686.883131168579, 12120.393980301125, 8090.6359213836695, 8215.0, 8222.671093156207, 8430.283425908867, 8728.127187281221, 8581.95709021451, 10762.3542587445, 11310.886891130984, 11316.94341528287, 11520.366379849189], "value": 9069.411898978116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.7650787620046, 1462.5246794791692, 1561.4769052367462, 1626.406361677988, 1687.11426501087, 7307.378872795805, 7495.775126746193, 7891.526508409493, 8469.153084691528, 8470.491770493774, 7971.0, 8220.753377398672, 8234.135415781331, 8353.791155221123, 8431.114732953043, 2293.3578597992587, 2326.6975293211945, 2327.2785436514737, 2332.895019724108, 2344.1443872986406, 2347.7065366829147, 2375.0262392419113, 2388.2715771689627, 2394.604890193125, 2421.576224160765, 2295.4031951692596, 2295.483516208856, 2299.977000229993, 2324.337563794319, 2330.0330362899376, 2238.2389987404363, 2276.1919518570917, 2286.8856557172076, 2295.150794206146, 2302.3093072078395, 2226.332100369899, 2228.43174990378, 2234.4748983988748, 2249.3139592424304, 2275.453891066132, 8190.467619604707, 8294.212049855254, 8381.622826972802, 8427.747167584983, 8431.494110353398, 4977.776000080005, 5156.0, 5157.252198431244, 5158.148905430599, 5163.432022477562, 3080.738137258336, 3109.8911538096286, 3367.0908854609365, 3398.3033478137168, 3406.148462884279, 1093.4805967165612, 1103.1836441033577, 1123.3989815448776, 1133.6939026462892, 1162.250348525205, 11366.488508017159, 11386.54453821846, 11422.428878556038, 11497.367644779533, 11500.482478288497, 4411.316245981878, 4527.909441811145, 4731.716097034189, 4735.266033764772, 4737.59730422911, 9495.05049495045, 9579.233661307078, 9596.520173991272, 9620.807583848424, 9640.903590964, 5153.768080436389, 5158.948410515847, 5190.325257716549, 5193.870153246124, 5211.0359583477175, 4098.200850834119, 4158.793949754598, 4569.1547063793305, 4668.719876807335, 4722.881927951828, 3683.318586061587, 3772.2266935278203, 3830.559485659129, 3836.635519625631, 3864.401017842239, 1196.0, 1239.5289789879969, 1240.3736113262744, 1265.8923991460645, 1282.1345591725549, 947.924166066713, 966.6133546581283, 984.7931934293736, 995.7162208770466, 998.9361330183332, 5676.432356764373, 5762.423757624204, 5782.161586569924, 5804.100364443518, 5867.119932010232, 393.53366260980255, 416.74578507110635, 420.60253060857195, 420.6403524986154, 426.5585119401405, 3784.3377408953324, 3907.765534067965, 3909.6090390961244, 3935.9803200984384, 4039.939400908989, 8992.955035224782, 9405.482698451515, 9422.057794220524, 9425.90574094264, 9537.2370210383, 9541.332106752461, 9566.33035687509, 9574.281928855224, 9574.617015319309, 9583.137517623447, 7407.962960185165, 7444.367228785505, 7536.133344665324, 7592.696292148363, 7712.074551053797, 5686.317641883001, 5713.542916566747, 5844.444777746107, 5908.084246941731, 5945.19739835134, 8905.0, 8983.505907174907, 9054.592543335433, 9056.13966673165, 9079.68221112258, 9021.90978090237, 9093.770138025098, 9116.680916167903, 9146.496942668216, 9173.724788256362, 6705.2959439258175, 6872.347127022925, 7163.892541611775, 7335.376492998155, 7457.552546847207, 7646.006019217466, 8066.395020373613, 8081.555514446762, 8085.353171746364, 8110.0, 7241.275872412716, 7341.632918353954, 7509.5869727163345, 7514.549127052394, 7570.848583028419, 7079.610621415665, 7190.352868241884, 7254.89117663246, 7282.927170728225, 7318.853622927618, 6213.9067913982235, 6299.905501417391, 6332.430081292706, 6337.493000559852, 6342.841428964312, 4713.882152946204, 4876.707397556158, 4931.334269873664, 4960.627952903475, 5023.623228257822, 4893.853184404474, 4930.704157750546, 5012.0, 5047.343845300087, 5075.847724568269], "value": 4328.455164349736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.0188267312667, 321.1617677860783, 326.49556435307454, 339.60436091952874, 343.40762185230466, 5356.4107948125675, 5409.486098820616, 5477.6713397196145, 5575.804846830361, 5585.162225666147, 5226.3728352597645, 5293.841184764454, 5348.839534813952, 5390.676559406428, 5434.456554344573, 4272.636825869805, 4285.492986602825, 4285.907093691105, 4287.31402975524, 4296.334068219423, 4145.253854306224, 4191.2874811282, 4220.725652832556, 4281.850135245267, 4313.223619748444, 4191.413202151702, 4194.5805419457965, 4215.936760948588, 4217.536071032184, 4222.535521092677, 4185.916281674349, 4200.222958752625, 4216.2832318505625, 4231.513375961773, 4248.532661407243, 3687.46531752897, 3763.717721170923, 3768.1144930941205, 3775.735698501106, 3778.0932576181795, 5257.291380301379, 5273.868153296198, 5282.471752824726, 5309.362876454811, 5338.119210330291, 4792.137415265251, 4839.080574690797, 4852.8544143675745, 4853.684510506806, 4856.562909338177, 5568.081266591048, 5648.576356773258, 5655.8586035349035, 5701.4013528579735, 5736.827895163152, 4130.215259100762, 4133.1940271647045, 4134.193832202722, 4142.937855932163, 4173.561776013536, 5866.917244378227, 5887.499562537189, 5908.97045514774, 5964.612300200516, 5972.9701351493395, 4184.163167366539, 4284.207421627009, 4305.440292761921, 4305.56944305567, 4308.46144231971, 4215.6205941464805, 4244.3209086546, 4249.746324834119, 4252.48970123581, 4290.2706539888295, 4832.347633069561, 4845.75771211445, 4863.076015557032, 4883.194272944996, 4890.779914903838, 5572.3870374258795, 5712.34308054579, 5730.366845449027, 5743.712814359349, 5750.951995442422, 1463.3488097796378, 1474.2849717886816, 1480.7704805755125, 1481.3852251315798, 1490.9552713418398, 895.705705255912, 938.521828120699, 953.1755031897497, 954.4607296877242, 954.4988880837616, 4824.34871292371, 4861.7326047067045, 4891.73095479752, 4899.828506002273, 4943.7640589852535, 5073.543381095646, 5135.512126347991, 5171.405288391883, 5172.5344718975475, 5205.9219111713355, 4678.619807156897, 4800.279958006257, 4856.465788763233, 4883.487233840467, 4900.387451568554, 2791.9581206281923, 2803.7897157713255, 2808.3119635689386, 2817.5351067073702, 2825.519661657523, 5357.491038351351, 5377.27406800077, 5404.864878377994, 5450.863728406822, 5472.5621950243885, 5018.623603229772, 5096.566791822663, 5142.61430392722, 5192.0, 5232.581393488512, 5169.043726910533, 5224.1528367040055, 5263.789448422097, 5313.734313284321, 5328.680279183184, 5103.540681338697, 5227.503387178212, 5239.528442440199, 5244.659097158673, 5249.7112658804135, 4860.810757677001, 5018.924716129334, 5063.721495317793, 5112.948870511247, 5127.564157046693, 5292.4442933492965, 5325.440828712929, 5350.545203657733, 5351.384590772111, 5400.351957765093, 3856.8264428101365, 4126.627189366187, 4233.97883010583, 4276.337167739005, 4313.115811258747, 5873.149957763291, 5919.4968427684125, 5922.851928701817, 5974.564625340534, 5982.252218472691, 5592.468715472024, 5898.761260135419, 5909.2908850938165, 5911.758530708427, 5914.3198532167635, 5726.942730572641, 5749.252597162509, 5761.251037365116, 5770.2498675171955, 5790.812883358985, 5713.542916566582, 5744.569157313302, 5761.703616686212, 5782.884342313046, 5796.536277097906, 5522.641028333145, 5770.586206379296, 5773.037167363117, 5780.283266864567, 5874.765009399747, 5728.713564321851, 5746.367899531132, 5764.913526297193, 5768.50967667753, 5815.709214539172], "value": 4219.341701647084, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.8121344810005, 737.5758938610297, 744.8212429017034, 770.0836005153863, 790.0716657926935, 14120.293985300732, 14140.151590904527, 14353.49762758301, 14492.420303187873, 15019.624509387271, 13245.668858278525, 13311.800322995163, 13465.66335841602, 13499.39252733627, 13516.32418379082, 786.1509569664763, 803.9758807235793, 809.0857331215718, 810.6109067647533, 811.5455345006785, 785.4305628419379, 814.0313027497289, 816.8039670479102, 824.5423789796661, 825.154216927648, 850.8298340331959, 853.714005808055, 855.1448551448551, 856.25933567464, 858.6951632170583, 849.5412477262271, 851.0723311590365, 851.8977722673256, 852.1393392673383, 854.6965827131341, 619.1023016625866, 619.7582942652369, 622.3527531367373, 622.4708997352215, 624.1386886097202, 13773.586792396243, 14563.854361456462, 14655.193964331958, 14655.63360915975, 14726.631834204123, 12921.418536165895, 12958.935205323913, 13247.271400072992, 13477.58485359033, 14230.928845355811, 11496.597619083292, 11532.67374251955, 11633.487646605887, 11694.239874408137, 12323.322217278046, 3755.6995440364703, 3886.2227554489214, 3923.5487918889407, 3947.3486874665646, 3949.8420063197436, 64115.35884641141, 66104.3389566103, 66330.66834665844, 67355.66322168407, 67545.0, 10780.622678206226, 10795.676129716121, 10810.729731756612, 10825.945870270756, 10996.28524145944, 18393.0, 19427.4171774847, 19445.611087778165, 19495.707564386546, 19552.804471955384, 7877.487963282369, 8309.792255193548, 8344.374171937008, 8433.0, 8493.235608795238, 4566.0, 4640.350350950869, 4732.006278681447, 4752.619790416758, 4800.5199480052415, 3302.2734998300334, 3322.8172450515453, 3336.199312165063, 3349.882754103595, 3380.797152170878, 583.4253260538367, 585.3034888482692, 587.3157771196509, 588.9558283128782, 619.4703528483172, 675.2007286623652, 684.8561802021532, 685.1675214614168, 693.2651389527017, 695.4714417043084, 8481.618327175293, 8913.643454261886, 8926.821463570692, 9021.188093071523, 9136.451812891248, 607.3713706314032, 650.7527139686889, 729.212450553401, 739.7743688175051, 775.5269285735696, 4257.74453532789, 4285.3786201000685, 4444.466664000341, 4756.548127927841, 4875.975620121877, 48046.27930581044, 69947.65026174836, 78139.0, 78230.6088469554, 83816.58091709625, 44977.77511112489, 60668.0, 67848.0, 71046.289537105, 72278.63860680768, 64747.67626161839, 65717.0, 65894.67052664707, 65906.67046664737, 66444.33555664479, 8888.200061994452, 9071.319651026331, 9093.499857507635, 9109.954450227706, 9151.313651476034, 43848.56151438572, 43979.34030989474, 45032.77483612692, 45081.774591126836, 46164.0, 56521.43478565326, 59819.40180598312, 60588.62314931304, 62223.0, 63553.364466356594, 10554.10290125348, 10589.735256618646, 10624.681259562225, 10722.303050301705, 11562.075033997427, 12418.441170147184, 12585.24488530691, 12621.621351359474, 12705.936470317589, 12871.0, 11219.270747401393, 11401.885981140415, 11506.654800356002, 11600.477978491157, 12165.939170304091, 11135.276207046516, 11225.71935701614, 11440.141989350666, 11479.540818367172, 12036.518539258332, 10658.200634952565, 10671.092957098423, 10933.671989840317, 11067.612633558108, 11300.830487542858, 9156.771080723036, 9763.463009534544, 9833.459159746282, 9865.654702085392, 9957.0, 8409.0, 9290.58192381358, 9405.764855878384, 10157.18742500613, 10232.539535720762], "value": 6821.519832817152, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 115.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 124.0, 167.0, 129.0, 124.0, 124.0, 126.0, 158.0, 124.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 171.0, 163.0, 161.0, 163.0, 166.0, 164.0, 161.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 111.0, 77.0, 76.0, 76.0, 75.0, 114.0, 77.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 82.0, 83.0, 83.0, 106.0, 81.0, 83.0, 113.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 86.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 54.0, 56.0, 56.0, 55.0, 54.0, 54.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 86.0, 80.0, 79.0, 82.0, 80.0, 85.0, 88.0, 79.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 136.0, 133.0, 135.0, 133.0, 138.0, 128.0, 138.0, 182.0, 128.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 165.0, 165.0, 170.0, 168.0, 169.0, 164.0, 165.0, 170.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 71.0, 66.0, 63.0, 66.0, 63.0, 65.0, 62.0, 67.0, 63.0], "value": 64.9, "unit": "score"}]}]} 14:07:59 INFO - Return code: 0 14:07:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:07:59 ERROR - # TBPL SUCCESS # 14:07:59 INFO - Running post-action listener: _resource_record_post_action 14:07:59 INFO - [mozharness: 2016-10-31 21:07:59.812828Z] Finished run-tests step (success) 14:07:59 INFO - Running post-run listener: _resource_record_post_run 14:07:59 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 8192; Write bytes: 399495168; Read time: 16; Write time: 314076 14:07:59 INFO - TinderboxPrint: CPU usage
13.5% 14:07:59 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 14:07:59 INFO - TinderboxPrint: I/O write bytes / time
399,495,168 / 314,076 14:07:59 INFO - TinderboxPrint: CPU idle
8,248.8 (86.5%) 14:07:59 INFO - TinderboxPrint: CPU user
1,224.4 (12.8%) 14:07:59 INFO - TinderboxPrint: Swap in / out
0 / 0 14:07:59 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110714880; Read time: 0; Write time: 90308 14:07:59 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288780288; Read time: 0; Write time: 223768 14:08:00 INFO - Running post-run listener: _upload_blobber_files 14:08:00 INFO - Blob upload gear active. 14:08:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:08:00 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 14:08:00 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:08:00 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:08:00 INFO - (blobuploader) - INFO - Open directory for files ... 14:08:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:08:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:08:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:01 INFO - (blobuploader) - INFO - Done attempting. 14:08:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:08:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:08:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:02 INFO - (blobuploader) - INFO - Done attempting. 14:08:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:08:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:08:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:08:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:08:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:08:05 INFO - (blobuploader) - INFO - Done attempting. 14:08:05 INFO - (blobuploader) - INFO - Iteration through files over. 14:08:05 INFO - Return code: 0 14:08:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:08:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:08:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61430729eca2d4e85e52a9be2dc97e81fc7f2c36c714d17d111f1c7281d3a477417aeb3400e3860c62e12a2236bf32a8c1a1ce0cdd75b3ac878e3092b848184d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81211d6143e814edb72dc7728983eefbe9028a6385e4f913fe7b9f415d79f6448586d7ec294a9c10004091f626b3bd0544789e731c72af9185cea812f373f430", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2532965062e2ae5f537bc8e5c9fbc3e6e79788462619e39174fd3218fc70c8b2b99a7afc1d67dc13a91292294e3622fc59a7a901059d17dae73cb0c0ef144e0a"} 14:08:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:08:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:08:05 INFO - Contents: 14:08:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61430729eca2d4e85e52a9be2dc97e81fc7f2c36c714d17d111f1c7281d3a477417aeb3400e3860c62e12a2236bf32a8c1a1ce0cdd75b3ac878e3092b848184d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81211d6143e814edb72dc7728983eefbe9028a6385e4f913fe7b9f415d79f6448586d7ec294a9c10004091f626b3bd0544789e731c72af9185cea812f373f430", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2532965062e2ae5f537bc8e5c9fbc3e6e79788462619e39174fd3218fc70c8b2b99a7afc1d67dc13a91292294e3622fc59a7a901059d17dae73cb0c0ef144e0a"} 14:08:05 INFO - Running post-run listener: copy_logs_to_upload_dir 14:08:05 INFO - Copying logs to upload dir... 14:08:05 INFO - mkdir: /builds/slave/test/build/upload/logs 14:08:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.372865 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-31 14:08:05.494161) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 14:08:05.497872) ========= 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=7de08804244eb36560b44971000001c3-1477946846.125646-2061573111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61430729eca2d4e85e52a9be2dc97e81fc7f2c36c714d17d111f1c7281d3a477417aeb3400e3860c62e12a2236bf32a8c1a1ce0cdd75b3ac878e3092b848184d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81211d6143e814edb72dc7728983eefbe9028a6385e4f913fe7b9f415d79f6448586d7ec294a9c10004091f626b3bd0544789e731c72af9185cea812f373f430", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2532965062e2ae5f537bc8e5c9fbc3e6e79788462619e39174fd3218fc70c8b2b99a7afc1d67dc13a91292294e3622fc59a7a901059d17dae73cb0c0ef144e0a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011406 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477888230/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/61430729eca2d4e85e52a9be2dc97e81fc7f2c36c714d17d111f1c7281d3a477417aeb3400e3860c62e12a2236bf32a8c1a1ce0cdd75b3ac878e3092b848184d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/81211d6143e814edb72dc7728983eefbe9028a6385e4f913fe7b9f415d79f6448586d7ec294a9c10004091f626b3bd0544789e731c72af9185cea812f373f430", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2532965062e2ae5f537bc8e5c9fbc3e6e79788462619e39174fd3218fc70c8b2b99a7afc1d67dc13a91292294e3622fc59a7a901059d17dae73cb0c0ef144e0a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-31 14:08:05.523253) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:08:05.523597) ========= 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=7de08804244eb36560b44971000001c3-1477946846.125646-2061573111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004495 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-31 14:08:05.605331) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 14:08:05.605657) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-31 14:08:05.605938) ========= ========= Total master_lag: 0.18 =========