builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1478547994.17 results: success (0) buildid: 20161107111205 builduid: fa6f095316c245c6aa6be36333dc1f29 revision: a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.172118) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.172831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.173300) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.190494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.191044) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-07 11:46:36-- 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% 30.0M=0s 2016-11-07 11:46:36 (30.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.295610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.296058) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018885 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:34.347147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 11:46:34.347545) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-07 11:46:36,945 truncating revision to first 12 chars 2016-11-07 11:46:36,946 Setting DEBUG logging. 2016-11-07 11:46:36,946 attempt 1/10 2016-11-07 11:46:36,946 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/a73ad8b09a99?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 11:46:38,273 unpacking tar archive at: mozilla-inbound-a73ad8b09a99/testing/mozharness/ program finished with exit code 0 elapsedTime=1.724041 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 11:46:36.086462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:36.086901) ========= script_repo_revision: a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:36.087324) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:36.087587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 11:46:36.100024) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-07 11:46:36.100643) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:46:38 INFO - MultiFileLogger online at 20161107 11:46:38 in /builds/slave/test 11:46:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 11:46:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:46:38 INFO - {'append_to_log': False, 11:46:38 INFO - 'base_work_dir': '/builds/slave/test', 11:46:38 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 11:46:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:46:38 INFO - 'branch': 'Mozilla-Inbound', 11:46:38 INFO - 'buildbot_json_path': 'buildprops.json', 11:46:38 INFO - 'config_files': ('talos/linux_config.py',), 11:46:38 INFO - 'default_actions': ('clobber', 11:46:38 INFO - 'read-buildbot-config', 11:46:38 INFO - 'download-and-extract', 11:46:38 INFO - 'populate-webroot', 11:46:38 INFO - 'create-virtualenv', 11:46:38 INFO - 'install', 11:46:38 INFO - 'run-tests'), 11:46:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:46:38 INFO - 'download_minidump_stackwalk': True, 11:46:38 INFO - 'download_symbols': 'ondemand', 11:46:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:46:38 INFO - 'tooltool.py': '/tools/tooltool.py', 11:46:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:46:38 INFO - '/tools/misc-python/virtualenv.py')}, 11:46:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:46:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:46:38 INFO - 'installer_path': 'installer.exe', 11:46:38 INFO - 'log_level': 'info', 11:46:38 INFO - 'log_name': 'talos', 11:46:38 INFO - 'log_to_console': True, 11:46:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:46:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:46:38 INFO - 'opt_config_files': (), 11:46:38 INFO - 'pip_index': False, 11:46:38 INFO - 'sps_profile': False, 11:46:38 INFO - 'sps_profile_interval': 0, 11:46:38 INFO - 'suite': 'dromaeojs-e10s', 11:46:38 INFO - 'system_bits': '32', 11:46:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:46:38 INFO - 'title': 'talos-linux64-ix-066', 11:46:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:46:38 INFO - 'use_talos_json': True, 11:46:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:46:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:46:38 INFO - 'work_dir': 'build'} 11:46:38 INFO - [mozharness: 2016-11-07 19:46:38.792408Z] Running clobber step. 11:46:38 INFO - Running pre-action listener: _resource_record_pre_action 11:46:38 INFO - Running main action method: clobber 11:46:38 INFO - rmtree: /builds/slave/test/build 11:46:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:46:39 INFO - Running post-action listener: _resource_record_post_action 11:46:39 INFO - [mozharness: 2016-11-07 19:46:39.255047Z] Finished clobber step (success) 11:46:39 INFO - [mozharness: 2016-11-07 19:46:39.255148Z] Running read-buildbot-config step. 11:46:39 INFO - Running pre-action listener: _resource_record_pre_action 11:46:39 INFO - Running main action method: read_buildbot_config 11:46:39 INFO - Using buildbot properties: 11:46:39 INFO - { 11:46:39 INFO - "project": "", 11:46:39 INFO - "product": "firefox", 11:46:39 INFO - "script_repo_revision": "production", 11:46:39 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 11:46:39 INFO - "repository": "", 11:46:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 11:46:39 INFO - "buildid": "20161107111205", 11:46:39 INFO - "stage_platform": "linux64-pgo", 11:46:39 INFO - "basedir": "/builds/slave/test", 11:46:39 INFO - "buildnumber": 1806, 11:46:39 INFO - "platform": "ubuntu64_hw", 11:46:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:46:39 INFO - "slavebuilddir": "test", 11:46:39 INFO - "branch": "mozilla-inbound", 11:46:39 INFO - "revision": "a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d", 11:46:39 INFO - "slavename": "talos-linux64-ix-066", 11:46:39 INFO - "builduid": "fa6f095316c245c6aa6be36333dc1f29", 11:46:39 INFO - "repo_path": "integration/mozilla-inbound" 11:46:39 INFO - } 11:46:39 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 11:46:39 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 11:46:39 INFO - Running post-action listener: _resource_record_post_action 11:46:39 INFO - [mozharness: 2016-11-07 19:46:39.257516Z] Finished read-buildbot-config step (success) 11:46:39 INFO - [mozharness: 2016-11-07 19:46:39.257603Z] Running download-and-extract step. 11:46:39 INFO - Running pre-action listener: _resource_record_pre_action 11:46:39 INFO - Running main action method: download_and_extract 11:46:39 INFO - mkdir: /builds/slave/test/build/tests 11:46: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')]} 11:46:39 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:46:39 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/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 11:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/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 11:46:39 INFO - Downloaded 1361 bytes. 11:46:39 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 11:46:39 INFO - Using the following test package requirements: 11:46:39 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:39 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:46:39 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:46:39 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'jsshell-linux-x86_64.zip'], 11:46:39 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:46:39 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 11:46:39 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:46:39 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:46:39 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:46:39 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 11:46:39 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:46:39 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:46:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:46:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:46:39 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:46:39 INFO - Http code: 200 11:46:39 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 11:46:39 INFO - x-amz-cf-id: Bc9EfDQZjvUCFW6kputks_cdbFBViCEdvHdyvf_mzF8ugfx3DV_CQg== 11:46:39 INFO - x-amz-replication-status: COMPLETED 11:46:39 INFO - x-amz-version-id: LuTfkbPMoLB6gphyVDsKFVebfFbk6dVL 11:46:39 INFO - Expected file size: 21922964 11:46:39 INFO - Obtained file size: 21922964 11:46:43 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 11:46:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 11:46:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:46:43 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 11:46:43 INFO - Http code: 200 11:46:43 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 11:46:43 INFO - x-amz-cf-id: sWtDyhim-cldntkDYmz_9CpDiJCWcY01V48_bks6OnDZtCRcJrzJaw== 11:46:43 INFO - x-amz-replication-status: COMPLETED 11:46:43 INFO - x-amz-version-id: LuTfkbPMoLB6gphyVDsKFVebfFbk6dVL 11:46:44 INFO - Expected file size: 21922964 11:46:44 INFO - Obtained file size: 21922964 11:46:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 11:46:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:46:48 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 11:46:48 INFO - Http code: 200 11:46:48 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 11:46:48 INFO - x-amz-cf-id: -VNT5yOqVer3A2QIpK8KinRV7foFnCOBBLGrdtNm7sccUXdfyc6GvA== 11:46:48 INFO - x-amz-replication-status: COMPLETED 11:46:48 INFO - x-amz-version-id: c6ATVilq83xfAfciQRVjX97x4rSxkuyP 11:46:48 INFO - Expected file size: 14409038 11:46:48 INFO - Obtained file size: 14409038 11:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:49 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:46:49 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/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 11:46:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/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 11:46:49 INFO - Downloaded 59585409 bytes. 11:46:49 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:46:49 INFO - mkdir: /builds/slave/test/properties 11:46:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:46:49 INFO - Writing to file /builds/slave/test/properties/build_url 11:46:49 INFO - Contents: 11:46:49 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 11:46:50 INFO - Running post-action listener: _resource_record_post_action 11:46:50 INFO - Running post-action listener: set_extra_try_arguments 11:46:50 INFO - [mozharness: 2016-11-07 19:46:50.125147Z] Finished download-and-extract step (success) 11:46:50 INFO - [mozharness: 2016-11-07 19:46:50.125376Z] Running populate-webroot step. 11:46:50 INFO - Running pre-action listener: _resource_record_pre_action 11:46:50 INFO - Running main action method: populate_webroot 11:46:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:46:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:46:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:46:50 INFO - '--tppagecycles', 11:46:50 INFO - '7'], 11:46:50 INFO - 'tests': ['tsvgm']}}, 11:46:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:46:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:46:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:46:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:46:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:46:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['damp', 'tps']}, 11:46:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'tests': ['damp', 'tps']}, 11:46:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['dromaeo_dom']}, 11:46:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:46:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['basic_compositor_video']}, 11:46:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:46:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['a11yr', 11:46:50 INFO - 'ts_paint', 11:46:50 INFO - 'tpaint', 11:46:50 INFO - 'sessionrestore', 11:46:50 INFO - 'sessionrestore_no_auto_restore', 11:46:50 INFO - 'tabpaint']}, 11:46:50 INFO - 'other-e10s': {'tests': ['a11yr', 11:46:50 INFO - 'ts_paint', 11:46:50 INFO - 'tpaint', 11:46:50 INFO - 'sessionrestore', 11:46:50 INFO - 'sessionrestore_no_auto_restore', 11:46:50 INFO - 'tabpaint']}, 11:46:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:46:50 INFO - 'ts_paint', 11:46:50 INFO - 'tpaint', 11:46:50 INFO - 'sessionrestore', 11:46:50 INFO - 'sessionrestore_no_auto_restore', 11:46:50 INFO - 'tabpaint']}, 11:46:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:46:50 INFO - 'ts_paint', 11:46:50 INFO - 'tpaint', 11:46:50 INFO - 'sessionrestore', 11:46:50 INFO - 'sessionrestore_no_auto_restore', 11:46:50 INFO - 'tabpaint']}, 11:46:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['a11yr', 11:46:50 INFO - 'ts_paint', 11:46:50 INFO - 'tpaint', 11:46:50 INFO - 'sessionrestore', 11:46:50 INFO - 'sessionrestore_no_auto_restore', 11:46:50 INFO - 'tabpaint']}, 11:46:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['a11yr', 11:46:50 INFO - 'ts_paint', 11:46:50 INFO - 'tpaint', 11:46:50 INFO - 'sessionrestore', 11:46:50 INFO - 'sessionrestore_no_auto_restore', 11:46:50 INFO - 'tabpaint']}, 11:46:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['tsvgx', 11:46:50 INFO - 'tsvgr_opacity', 11:46:50 INFO - 'tart', 11:46:50 INFO - 'tscrollx', 11:46:50 INFO - 'cart']}, 11:46:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:46:50 INFO - 'tsvgr_opacity', 11:46:50 INFO - 'tart', 11:46:50 INFO - 'tscrollx', 11:46:50 INFO - 'cart']}, 11:46:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'talos_options': ['--disable-e10s'], 11:46:50 INFO - 'tests': ['tp5o']}, 11:46:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'tests': ['tp5o']}, 11:46:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'talos_options': ['--disable-e10s', 11:46:50 INFO - '--xperf_path', 11:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:50 INFO - 'tests': ['tp5n']}, 11:46:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:46:50 INFO - 'talos_options': ['--xperf_path', 11:46:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:46:50 INFO - 'tests': ['tp5n']}}, 11:46:50 INFO - 'talos.zip': {'path': '', 11:46:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:46:50 INFO - Running post-action listener: _resource_record_post_action 11:46:50 INFO - [mozharness: 2016-11-07 19:46:50.140591Z] Finished populate-webroot step (success) 11:46:50 INFO - [mozharness: 2016-11-07 19:46:50.140680Z] Running create-virtualenv step. 11:46:50 INFO - Running pre-action listener: _resource_record_pre_action 11:46:50 INFO - Running main action method: create_virtualenv 11:46:50 INFO - Creating virtualenv /builds/slave/test/build/venv 11:46:50 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 11:46:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:46:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:46:50 INFO - Using real prefix '/usr' 11:46:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:46:50 INFO - Installing distribute.............................................................................................................................................................................................done. 11:46:52 INFO - Installing pip.................done. 11:46:52 INFO - Return code: 0 11:46:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:46:52 INFO - Reading from file tmpfile_stdout 11:46:52 INFO - Output received: 11:46:52 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) 11:46:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:46:52 INFO - Using env: {'DISPLAY': ':0', 11:46:52 INFO - 'HOME': '/home/cltbld', 11:46:52 INFO - 'LANG': 'en_US.UTF-8', 11:46:52 INFO - 'LANGUAGE': 'en_US:en', 11:46:52 INFO - 'LOGNAME': 'cltbld', 11:46:52 INFO - 'MAIL': '/var/mail/cltbld', 11:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:52 INFO - 'MOZ_NO_REMOTE': '1', 11:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:52 INFO - 'NO_EM_RESTART': '1', 11:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:52 INFO - 'PWD': '/builds/slave/test', 11:46:52 INFO - 'SHELL': '/bin/bash', 11:46:52 INFO - 'SHLVL': '1', 11:46:52 INFO - 'TERM': 'linux', 11:46:52 INFO - 'TMOUT': '86400', 11:46:52 INFO - 'USER': 'cltbld', 11:46:52 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:52 INFO - '_': '/tools/buildbot/bin/python'} 11:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:53 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 11:46:53 INFO - Cleaning up... 11:46:53 INFO - Return code: 0 11:46:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:46:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:46:53 INFO - Using env: {'DISPLAY': ':0', 11:46:53 INFO - 'HOME': '/home/cltbld', 11:46:53 INFO - 'LANG': 'en_US.UTF-8', 11:46:53 INFO - 'LANGUAGE': 'en_US:en', 11:46:53 INFO - 'LOGNAME': 'cltbld', 11:46:53 INFO - 'MAIL': '/var/mail/cltbld', 11:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:53 INFO - 'MOZ_NO_REMOTE': '1', 11:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:53 INFO - 'NO_EM_RESTART': '1', 11:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:53 INFO - 'PWD': '/builds/slave/test', 11:46:53 INFO - 'SHELL': '/bin/bash', 11:46:53 INFO - 'SHLVL': '1', 11:46:53 INFO - 'TERM': 'linux', 11:46:53 INFO - 'TMOUT': '86400', 11:46:53 INFO - 'USER': 'cltbld', 11:46:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:53 INFO - '_': '/tools/buildbot/bin/python'} 11:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:53 INFO - Downloading/unpacking psutil>=3.1.1 11:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:55 INFO - Installing collected packages: psutil 11:46:55 INFO - Running setup.py install for psutil 11:46:55 INFO - building 'psutil._psutil_linux' extension 11:46:55 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 11:46:55 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 11:46:55 INFO - building 'psutil._psutil_posix' extension 11:46:55 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 11:46:55 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 11:46:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:46:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:46:55 INFO - Successfully installed psutil 11:46:55 INFO - Cleaning up... 11:46:55 INFO - Return code: 0 11:46:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:55 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:46:55 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 11:46:55 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 11:46:55 INFO - Using env: {'DISPLAY': ':0', 11:46:55 INFO - 'HOME': '/home/cltbld', 11:46:55 INFO - 'LANG': 'en_US.UTF-8', 11:46:55 INFO - 'LANGUAGE': 'en_US:en', 11:46:55 INFO - 'LOGNAME': 'cltbld', 11:46:55 INFO - 'MAIL': '/var/mail/cltbld', 11:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:55 INFO - 'MOZ_NO_REMOTE': '1', 11:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:55 INFO - 'NO_EM_RESTART': '1', 11:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:55 INFO - 'PWD': '/builds/slave/test', 11:46:55 INFO - 'SHELL': '/bin/bash', 11:46:55 INFO - 'SHLVL': '1', 11:46:55 INFO - 'TERM': 'linux', 11:46:55 INFO - 'TMOUT': '86400', 11:46:55 INFO - 'USER': 'cltbld', 11:46:55 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:55 INFO - '_': '/tools/buildbot/bin/python'} 11:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:46:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:46:58 INFO - Installing collected packages: mozsystemmonitor 11:46:58 INFO - Running setup.py install for mozsystemmonitor 11:46:58 INFO - Successfully installed mozsystemmonitor 11:46:58 INFO - Cleaning up... 11:46:58 INFO - Return code: 0 11:46:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:46: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')]} 11:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46: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')]} 11:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:46:58 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:46:58 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 11:46:58 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 11:46:58 INFO - Using env: {'DISPLAY': ':0', 11:46:58 INFO - 'HOME': '/home/cltbld', 11:46:58 INFO - 'LANG': 'en_US.UTF-8', 11:46:58 INFO - 'LANGUAGE': 'en_US:en', 11:46:58 INFO - 'LOGNAME': 'cltbld', 11:46:58 INFO - 'MAIL': '/var/mail/cltbld', 11:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:46:58 INFO - 'MOZ_NO_REMOTE': '1', 11:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:46:58 INFO - 'NO_EM_RESTART': '1', 11:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:46:58 INFO - 'PWD': '/builds/slave/test', 11:46:58 INFO - 'SHELL': '/bin/bash', 11:46:58 INFO - 'SHLVL': '1', 11:46:58 INFO - 'TERM': 'linux', 11:46:58 INFO - 'TMOUT': '86400', 11:46:58 INFO - 'USER': 'cltbld', 11:46:58 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:46:58 INFO - '_': '/tools/buildbot/bin/python'} 11:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:46:58 INFO - Downloading/unpacking jsonschema==2.5.1 11:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:46:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:46:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:47:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:01 INFO - Downloading functools32-3.2.3-2.tar.gz 11:47:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:47:01 INFO - warning: no files found matching '*.txt' 11:47:01 INFO - no previously-included directories found matching 'build' 11:47:01 INFO - no previously-included directories found matching 'dist' 11:47:01 INFO - no previously-included directories found matching '.git*' 11:47:01 INFO - Installing collected packages: jsonschema, functools32 11:47:01 INFO - Running setup.py install for functools32 11:47:01 INFO - warning: no files found matching '*.txt' 11:47:01 INFO - no previously-included directories found matching 'build' 11:47:01 INFO - no previously-included directories found matching 'dist' 11:47:01 INFO - no previously-included directories found matching '.git*' 11:47:01 INFO - Successfully installed jsonschema functools32 11:47:01 INFO - Cleaning up... 11:47:01 INFO - Return code: 0 11:47:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:01 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:47:01 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 11:47:01 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 11:47:01 INFO - Using env: {'DISPLAY': ':0', 11:47:01 INFO - 'HOME': '/home/cltbld', 11:47:01 INFO - 'LANG': 'en_US.UTF-8', 11:47:01 INFO - 'LANGUAGE': 'en_US:en', 11:47:01 INFO - 'LOGNAME': 'cltbld', 11:47:01 INFO - 'MAIL': '/var/mail/cltbld', 11:47:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:01 INFO - 'MOZ_NO_REMOTE': '1', 11:47:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:01 INFO - 'NO_EM_RESTART': '1', 11:47:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:01 INFO - 'PWD': '/builds/slave/test', 11:47:01 INFO - 'SHELL': '/bin/bash', 11:47:01 INFO - 'SHLVL': '1', 11:47:01 INFO - 'TERM': 'linux', 11:47:01 INFO - 'TMOUT': '86400', 11:47:01 INFO - 'USER': 'cltbld', 11:47:01 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:01 INFO - '_': '/tools/buildbot/bin/python'} 11:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:47:02 INFO - Cleaning up... 11:47:02 INFO - Return code: 0 11:47:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:47:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:47:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:47:02 INFO - Using env: {'DISPLAY': ':0', 11:47:02 INFO - 'HOME': '/home/cltbld', 11:47:02 INFO - 'LANG': 'en_US.UTF-8', 11:47:02 INFO - 'LANGUAGE': 'en_US:en', 11:47:02 INFO - 'LOGNAME': 'cltbld', 11:47:02 INFO - 'MAIL': '/var/mail/cltbld', 11:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:02 INFO - 'MOZ_NO_REMOTE': '1', 11:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:02 INFO - 'NO_EM_RESTART': '1', 11:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:02 INFO - 'PWD': '/builds/slave/test', 11:47:02 INFO - 'SHELL': '/bin/bash', 11:47:02 INFO - 'SHLVL': '1', 11:47:02 INFO - 'TERM': 'linux', 11:47:02 INFO - 'TMOUT': '86400', 11:47:02 INFO - 'USER': 'cltbld', 11:47:02 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:02 INFO - '_': '/tools/buildbot/bin/python'} 11:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:02 INFO - Downloading/unpacking blobuploader==1.2.4 11:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:04 INFO - Downloading blobuploader-1.2.4.tar.gz 11:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:47:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:47:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:47:05 INFO - Downloading docopt-0.6.1.tar.gz 11:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:47:05 INFO - Installing collected packages: blobuploader, requests, docopt 11:47:05 INFO - Running setup.py install for blobuploader 11:47:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:47:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:47:05 INFO - Running setup.py install for requests 11:47:05 INFO - Running setup.py install for docopt 11:47:05 INFO - Successfully installed blobuploader requests docopt 11:47:05 INFO - Cleaning up... 11:47:05 INFO - Return code: 0 11:47:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:05 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:47:05 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 11:47:05 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 11:47:05 INFO - Using env: {'DISPLAY': ':0', 11:47:05 INFO - 'HOME': '/home/cltbld', 11:47:05 INFO - 'LANG': 'en_US.UTF-8', 11:47:05 INFO - 'LANGUAGE': 'en_US:en', 11:47:05 INFO - 'LOGNAME': 'cltbld', 11:47:05 INFO - 'MAIL': '/var/mail/cltbld', 11:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:05 INFO - 'MOZ_NO_REMOTE': '1', 11:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:05 INFO - 'NO_EM_RESTART': '1', 11:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:05 INFO - 'PWD': '/builds/slave/test', 11:47:05 INFO - 'SHELL': '/bin/bash', 11:47:05 INFO - 'SHLVL': '1', 11:47:05 INFO - 'TERM': 'linux', 11:47:05 INFO - 'TMOUT': '86400', 11:47:05 INFO - 'USER': 'cltbld', 11:47:05 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:05 INFO - '_': '/tools/buildbot/bin/python'} 11:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:06 INFO - Running setup.py (path:/tmp/pip-1uV0cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:06 INFO - Running setup.py (path:/tmp/pip-tKPs1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:06 INFO - Running setup.py (path:/tmp/pip-z9dyVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:06 INFO - Running setup.py (path:/tmp/pip-e7DWOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:06 INFO - Running setup.py (path:/tmp/pip-cy2LQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:06 INFO - Running setup.py (path:/tmp/pip-2MX3DL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:06 INFO - Running setup.py (path:/tmp/pip-b8fX9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:06 INFO - Running setup.py (path:/tmp/pip-TSmeOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:06 INFO - Running setup.py (path:/tmp/pip-1ur0QA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:06 INFO - Running setup.py (path:/tmp/pip-lGtTwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:06 INFO - Running setup.py (path:/tmp/pip-hdDjJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:06 INFO - Running setup.py (path:/tmp/pip-i90ZyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:07 INFO - Running setup.py (path:/tmp/pip-AjBLbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:07 INFO - Running setup.py (path:/tmp/pip-BKdhB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:07 INFO - Running setup.py (path:/tmp/pip-wpi7B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:07 INFO - Running setup.py (path:/tmp/pip-EcSI1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:07 INFO - Running setup.py (path:/tmp/pip-EpZiZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:47:07 INFO - Running setup.py install for manifestparser 11:47:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:47:07 INFO - Running setup.py install for mozcrash 11:47:07 INFO - Running setup.py install for mozdebug 11:47:07 INFO - Running setup.py install for mozdevice 11:47:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:47:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:47:07 INFO - Running setup.py install for mozfile 11:47:07 INFO - Running setup.py install for mozhttpd 11:47:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:47:07 INFO - Running setup.py install for mozinfo 11:47:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Running setup.py install for mozInstall 11:47:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Running setup.py install for mozleak 11:47:08 INFO - Running setup.py install for mozlog 11:47:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Running setup.py install for moznetwork 11:47:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Running setup.py install for mozprocess 11:47:08 INFO - Running setup.py install for mozprofile 11:47:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Running setup.py install for mozrunner 11:47:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:47:08 INFO - Running setup.py install for mozscreenshot 11:47:08 INFO - Running setup.py install for moztest 11:47:09 INFO - Running setup.py install for mozversion 11:47:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:47:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:47:09 INFO - Cleaning up... 11:47:09 INFO - Return code: 0 11:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:09 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:47:09 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 11:47:09 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 11:47:09 INFO - Using env: {'DISPLAY': ':0', 11:47:09 INFO - 'HOME': '/home/cltbld', 11:47:09 INFO - 'LANG': 'en_US.UTF-8', 11:47:09 INFO - 'LANGUAGE': 'en_US:en', 11:47:09 INFO - 'LOGNAME': 'cltbld', 11:47:09 INFO - 'MAIL': '/var/mail/cltbld', 11:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:09 INFO - 'MOZ_NO_REMOTE': '1', 11:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:09 INFO - 'NO_EM_RESTART': '1', 11:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:09 INFO - 'PWD': '/builds/slave/test', 11:47:09 INFO - 'SHELL': '/bin/bash', 11:47:09 INFO - 'SHLVL': '1', 11:47:09 INFO - 'TERM': 'linux', 11:47:09 INFO - 'TMOUT': '86400', 11:47:09 INFO - 'USER': 'cltbld', 11:47:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:09 INFO - '_': '/tools/buildbot/bin/python'} 11:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:47:09 INFO - Running setup.py (path:/tmp/pip-lbNH3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:47:09 INFO - Running setup.py (path:/tmp/pip-BkIBtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:47:09 INFO - Running setup.py (path:/tmp/pip-axRv1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:47:09 INFO - Running setup.py (path:/tmp/pip-jSqvRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:47:09 INFO - Running setup.py (path:/tmp/pip-HaMzgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:47:09 INFO - Running setup.py (path:/tmp/pip-pJohUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:47:09 INFO - Running setup.py (path:/tmp/pip-4MLNIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:47:09 INFO - Running setup.py (path:/tmp/pip-8RtdsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:47:09 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)) 11:47:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:47:09 INFO - Running setup.py (path:/tmp/pip-fBroJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:47:10 INFO - Running setup.py (path:/tmp/pip-nH99OI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:47:10 INFO - Running setup.py (path:/tmp/pip-itKIWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:47:10 INFO - Running setup.py (path:/tmp/pip-iGAUpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:47:10 INFO - Running setup.py (path:/tmp/pip-nyVhX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:47:10 INFO - Running setup.py (path:/tmp/pip-y1nlOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:10 INFO - Running setup.py (path:/tmp/pip-6CLu1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:47:10 INFO - Running setup.py (path:/tmp/pip-VPFEWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:47:10 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)) 11:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:47:10 INFO - Running setup.py (path:/tmp/pip-YR7EpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:47:10 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)) 11:47:10 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)) 11:47:10 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)) 11:47:10 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)) 11:47:10 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)) 11:47:10 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)) 11:47:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:47:10 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 11:47:10 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 11:47:10 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 11:47:10 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 11:47:10 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 11:47:10 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 11:47:12 INFO - Downloading blessings-1.6.tar.gz 11:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:47:12 INFO - Installing collected packages: blessings 11:47:12 INFO - Running setup.py install for blessings 11:47:12 INFO - Successfully installed blessings 11:47:12 INFO - Cleaning up... 11:47:12 INFO - Return code: 0 11:47:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:13 INFO - Reading from file tmpfile_stdout 11:47:13 INFO - Current package versions: 11:47:13 INFO - argparse == 1.2.1 11:47:13 INFO - blessings == 1.6 11:47:13 INFO - blobuploader == 1.2.4 11:47:13 INFO - docopt == 0.6.1 11:47:13 INFO - functools32 == 3.2.3-2 11:47:13 INFO - jsonschema == 2.5.1 11:47:13 INFO - manifestparser == 1.1 11:47:13 INFO - mozInstall == 1.12 11:47:13 INFO - mozcrash == 0.17 11:47:13 INFO - mozdebug == 0.1 11:47:13 INFO - mozdevice == 0.48 11:47:13 INFO - mozfile == 1.2 11:47:13 INFO - mozhttpd == 0.7 11:47:13 INFO - mozinfo == 0.9 11:47:13 INFO - mozleak == 0.1 11:47:13 INFO - mozlog == 3.4 11:47:13 INFO - moznetwork == 0.27 11:47:13 INFO - mozprocess == 0.23 11:47:13 INFO - mozprofile == 0.28 11:47:13 INFO - mozrunner == 6.12 11:47:13 INFO - mozscreenshot == 0.1 11:47:13 INFO - mozsystemmonitor == 0.3 11:47:13 INFO - moztest == 0.7 11:47:13 INFO - mozversion == 1.4 11:47:13 INFO - psutil == 3.1.1 11:47:13 INFO - requests == 1.2.3 11:47:13 INFO - wsgiref == 0.1.2 11:47:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:47:13 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')]} 11:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:13 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')]} 11:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:13 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:47:13 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 11:47:13 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 11:47:13 INFO - Using env: {'DISPLAY': ':0', 11:47:13 INFO - 'HOME': '/home/cltbld', 11:47:13 INFO - 'LANG': 'en_US.UTF-8', 11:47:13 INFO - 'LANGUAGE': 'en_US:en', 11:47:13 INFO - 'LOGNAME': 'cltbld', 11:47:13 INFO - 'MAIL': '/var/mail/cltbld', 11:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:13 INFO - 'MOZ_NO_REMOTE': '1', 11:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:13 INFO - 'NO_EM_RESTART': '1', 11:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:13 INFO - 'PWD': '/builds/slave/test', 11:47:13 INFO - 'SHELL': '/bin/bash', 11:47:13 INFO - 'SHLVL': '1', 11:47:13 INFO - 'TERM': 'linux', 11:47:13 INFO - 'TMOUT': '86400', 11:47:13 INFO - 'USER': 'cltbld', 11:47:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:13 INFO - '_': '/tools/buildbot/bin/python'} 11:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 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)) 11:47:13 INFO - Cleaning up... 11:47:13 INFO - Return code: 0 11:47:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:47:13 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')]} 11:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:13 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')]} 11:47:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:47:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:47:13 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 0x7ff593701f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19a0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', '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 11:47:13 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 11:47:13 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 11:47:13 INFO - Using env: {'DISPLAY': ':0', 11:47:13 INFO - 'HOME': '/home/cltbld', 11:47:13 INFO - 'LANG': 'en_US.UTF-8', 11:47:13 INFO - 'LANGUAGE': 'en_US:en', 11:47:13 INFO - 'LOGNAME': 'cltbld', 11:47:13 INFO - 'MAIL': '/var/mail/cltbld', 11:47:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:13 INFO - 'MOZ_NO_REMOTE': '1', 11:47:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:13 INFO - 'NO_EM_RESTART': '1', 11:47:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:13 INFO - 'PWD': '/builds/slave/test', 11:47:13 INFO - 'SHELL': '/bin/bash', 11:47:13 INFO - 'SHLVL': '1', 11:47:13 INFO - 'TERM': 'linux', 11:47:13 INFO - 'TMOUT': '86400', 11:47:13 INFO - 'USER': 'cltbld', 11:47:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:13 INFO - '_': '/tools/buildbot/bin/python'} 11:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:47:13 INFO - Cleaning up... 11:47:13 INFO - Return code: 0 11:47:13 INFO - Running post-action listener: _resource_record_post_action 11:47:13 INFO - Running post-action listener: _start_resource_monitoring 11:47:13 INFO - Starting resource monitoring. 11:47:13 INFO - [mozharness: 2016-11-07 19:47:13.520090Z] Finished create-virtualenv step (success) 11:47:13 INFO - [mozharness: 2016-11-07 19:47:13.520717Z] Running install step. 11:47:13 INFO - Running pre-action listener: _resource_record_pre_action 11:47:13 INFO - Running main action method: install 11:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:47:13 INFO - Reading from file tmpfile_stdout 11:47:13 INFO - Detecting whether we're running mozinstall >=1.0... 11:47:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:47:13 INFO - Reading from file tmpfile_stdout 11:47:13 INFO - Output received: 11:47:13 INFO - Usage: mozinstall [options] installer 11:47:13 INFO - Options: 11:47:13 INFO - -h, --help show this help message and exit 11:47:13 INFO - -d DEST, --destination=DEST 11:47:13 INFO - Directory to install application into. [default: 11:47:13 INFO - "/builds/slave/test"] 11:47:13 INFO - --app=APP Application being installed. [default: firefox] 11:47:13 INFO - mkdir: /builds/slave/test/build/application 11:47:13 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'] 11:47:13 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 11:47:30 INFO - Reading from file tmpfile_stdout 11:47:30 INFO - Output received: 11:47:30 INFO - /builds/slave/test/build/application/firefox/firefox 11:47:30 INFO - Running post-action listener: _resource_record_post_action 11:47:30 INFO - [mozharness: 2016-11-07 19:47:30.756899Z] Finished install step (success) 11:47:30 INFO - [mozharness: 2016-11-07 19:47:30.757175Z] Running run-tests step. 11:47:30 INFO - Running pre-action listener: _resource_record_pre_action 11:47:30 INFO - Running main action method: run_tests 11:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:47:30 INFO - Python 2.7.3 11:47:30 INFO - Return code: 0 11:47:30 INFO - grabbing minidump binary from tooltool 11:47:30 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')]} 11:47:30 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 0x199df60>, '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 0x199ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:47:30 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 11:47:30 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 11:47:30 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 11:47:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:47:30 INFO - Return code: 0 11:47:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:47:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:47:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:47:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:47:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:47:30 INFO - Using env: {'DISPLAY': ':0', 11:47:30 INFO - 'HOME': '/home/cltbld', 11:47:30 INFO - 'LANG': 'en_US.UTF-8', 11:47:30 INFO - 'LANGUAGE': 'en_US:en', 11:47:30 INFO - 'LOGNAME': 'cltbld', 11:47:30 INFO - 'MAIL': '/var/mail/cltbld', 11:47:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:47:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:47:30 INFO - 'MOZ_NO_REMOTE': '1', 11:47:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:47:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:47:30 INFO - 'NO_EM_RESTART': '1', 11:47:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:47:30 INFO - 'PWD': '/builds/slave/test', 11:47:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:47:30 INFO - 'SHELL': '/bin/bash', 11:47:30 INFO - 'SHLVL': '1', 11:47:30 INFO - 'TERM': 'linux', 11:47:30 INFO - 'TMOUT': '86400', 11:47:30 INFO - 'USER': 'cltbld', 11:47:30 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063', 11:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:47:30 INFO - '_': '/tools/buildbot/bin/python'} 11:47:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:47:31 INFO - mozversion application_buildid: 20161107093011 11:47:31 INFO - mozversion application_changeset: a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d 11:47:31 INFO - mozversion application_display_name: Nightly 11:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:47:31 INFO - mozversion application_name: Firefox 11:47:31 INFO - mozversion application_remotingname: firefox 11:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:47:31 INFO - mozversion application_vendor: Mozilla 11:47:31 INFO - mozversion application_version: 52.0a1 11:47:31 INFO - mozversion platform_buildid: 20161107093011 11:47:31 INFO - mozversion platform_changeset: a73ad8b09a99eb4c7ec3d2942c81d8892dc34a1d 11:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 11:47:31 INFO - mozversion platform_version: 52.0a1 11:47:31 INFO - using testdate: 1478548051 11:47:31 INFO - actual date: 1478548051 11:47:31 INFO - starting webserver on 'localhost:59784' 11:47:31 INFO - SUITE-START | Running 2 tests 11:47:31 INFO - TEST-START | dromaeo_css 11:47:31 INFO - operating with platform_type : linux_ 11:47:31 INFO - Initialising browser for dromaeo_css test... 11:47:31 INFO - TEST-INFO | started process 17032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp98e2s2/profile http://localhost:59784/getInfo.html) 11:47:35 INFO - PROCESS | 17032 | __metrics Screen width/height:1600/1200 11:47:35 INFO - PROCESS | 17032 | colorDepth:24 11:47:35 INFO - PROCESS | 17032 | Browser inner width/height: 1024/697 11:47:35 INFO - PROCESS | 17032 | __metrics 11:47:36 ERROR - PROCESS | 17032 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 11:47:37 INFO - TEST-INFO | 17032: exit 0 11:47:37 INFO - Browser initialized. 11:47:37 INFO - Running cycle 1/1 for dromaeo_css test... 11:47:37 INFO - TEST-INFO | started process 17160 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp98e2s2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:49 INFO - PROCESS | 17160 | RSS: Main: 185774080 11:47:49 INFO - PROCESS | 17160 | 11:48:39 INFO - PROCESS | 17160 | 1478548119429 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] 11:50:49 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:59784/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59784/tests/dromaeo/cssquery-ext.html) 11:50:51 INFO - PROCESS | 17160 | RSS: Main: 198316032 11:50:51 INFO - PROCESS | 17160 | 11:53:54 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:59784/tests/dromaeo/cssquery-ext.html (next: http://localhost:59784/tests/dromaeo/cssquery-jquery.html) 11:53:54 INFO - PROCESS | 17160 | RSS: Main: 196870144 11:53:54 INFO - PROCESS | 17160 | 11:56:56 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:59784/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59784/tests/dromaeo/cssquery-mootools.html) 11:56:57 INFO - PROCESS | 17160 | RSS: Main: 198189056 11:56:57 INFO - PROCESS | 17160 | 11:59:59 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:59784/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59784/tests/dromaeo/cssquery-prototype.html) 12:00:00 INFO - PROCESS | 17160 | RSS: Main: 194686976 12:00:00 INFO - PROCESS | 17160 | 12:03:02 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:59784/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59784/tests/dromaeo/cssquery-yui.html) 12:03:03 INFO - PROCESS | 17160 | RSS: Main: 198262784 12:03:03 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | Cycle 1(1): loaded http://localhost:59784/tests/dromaeo/cssquery-yui.html (next: http://localhost:59784/tests/dromaeo/cssquery-dojo.html) 12:06:06 INFO - PROCESS | 17160 | RSS: Main: 198496256 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | __start_tp_report 12:06:06 INFO - PROCESS | 17160 | _x_x_mozilla_page_load 12:06:06 INFO - PROCESS | 17160 | _x_x_mozilla_page_load_details 12:06:06 INFO - PROCESS | 17160 | |i|pagename|runs| 12:06:06 INFO - PROCESS | 17160 | |0;dojo.html;3077.47682893908;3082.7842051056437;3089.11960091374;3098.1944694379454;3117.4076925384175;5138.665986710861;5253.317068781058;5264.578833693305;5323.068463018971;5406.729663516828;5195.922061169076;5207.0366982108335;5264.236685680574;5270.81552145675;5341.893162136755;4872.317875497424;4908.9263661045115;4913;4963.900721985558;4970.055689419017;4904.975475122619;4911.582515486188;4919.360483137187;4941.678790878582;5074;5016.2224855147515;5026.949730502684;5036.169032109698;5037.748112594374;5041.873953151182;4743.501932297094;4789.449213340476;4865.075635629254;4886.51134886512;4939.259111133323;4796.880077998078;4825.227963525854;4841.564259216652;4845.3216549683075;4914.238293064581;5293.57651387888;5305.946940530584;5371.677699338014;5377.354717433894;5399.541039011689;5683.318001839806;5711.257536520267;5712.685802280873;5760.193572899798;5775.913361299584;5758.88482230353;5814.97092514539;5815.098659707752;5819.883602327972;5863.677497737623;5406.162044883049;5438.592105592096;5442.210879422461;5443.482869127427;5461.42655021225;5609.326880774333;5640.379558248589;5745.88508229833;5783.681897495678;5912.674802885796;5617.8033768817895;5627.71861406928;5631.80288689902;5655;5677.233573467529;5723.084306510938;5733.31200255972;5734.713264336767;5740.655560666373;5742.425757424224;5523.143912693539;5597.80407685729;5618.719064046782;5650.406707295675;5693.715314234271;5652.802151924663;5675.659460432387;5712.34308054579;5716.342620598602;5721.599488035881;4312.37470566766;4319.9784001080425;4327.783610819446;4344.522102568715;4360.236958532308;3800.315943130208;3810.237952409529;3833.2716783811543;3894.746841455353;3914.9038269284647;5370.301860758154;5472.370677372073;5508.091164957737;5528;5575.219469274305;5736.823951090017;5779.162021506858;5788.21859049023;5798.88402231953;5803.216565763652;5372.892542149135;5498.422665620133;5513.3108361454815;5525.530329921921;5528.55771538284;4700.130475861908;4738.881527961759;4772.880677983008;4780.856574302777;4854.563089321978;5913.46778789911;5939.46544810969;5962.25471816023;5987.251593550806;5990.161377407167;5744.425557444222;5780.508656764054;5781.624194427349;5781.624194427349;5784.82645520635;5577.721113944205;5758.568107391879;5769.8557536061935;5829.183914251923;5878.3239927408895;5475.72621368922;5567.749451274622;5578.721063946868;5579.497845193952;5582.7766889323975;5614.185943038155;5615.129654903497;5622.409646987171;5622.9156562652415;5643.435656434488;5465.398806131402;5499.670019798665;5502.9174562380795;5505.779768809202;5516.586256030733;5487.75305111263;5500.862478437911;5502.394736578893;5508.834734957958;5541.667499950016;5413.377461591967;5450.400455949922;5454.754536045808;5470.562355011669;5478.534324582455;5510.8071217507195;5573.359063707726;5618.578606604603;5636.098224284259;5678.233438485751;5504.779808807602;5505.064139096283;5522.530584900168;5541.445855414427;5543.1685247213245 12:06:06 INFO - PROCESS | 17160 | |1;ext.html;572.2046355565762;582.1645938078857;589.4842013238414;591.0897218283843;623.6476390839173;36917.261654766924;40548.79725601371;40922.181556368894;40935.59064409355;40942;39894;40507.59492405075;40754.7962260189;40794.59205407945;40918;8511.489310641366;8553.700620478285;8661.653533858638;8670.13298670131;8675;8475.110113438093;8489.108643592426;8564.057953625097;8564.871526927102;8577.228049475545;8590.441621294627;8598.22615964563;8603.870941935877;8626;8640.351973601973;8550.315974722007;8569.828603427928;8591.914080859206;8594.441361311494;8619.870701939475;8456.746297611082;8477.703280385156;8507;8529.957350213272;8542.871856922151;39758.60241397578;40027;40088;40396.394054089214;40489.39265911013;3480.095175254427;3520.2431477232517;3535.840887160084;3643.052806270389;3710.350688629479;30889.382212355627;31040.223994400094;31272.687273127205;31315.84342078275;31398.215044623837;4115.444415003966;4191.08576863821;4243.978780106079;4272.230998420283;4347.630451411602;322464;327048;327528;327993;330895;55946;56060;56073.06575217875;56286.718566406904;56412.153817692764;59031.70484147552;59258.40741592615;59385.70307148523;59493.405065948784;59832.70083649554;15734.213289335716;16048.679026419406;16053.117078560557;16090;16103.838961610234;12395.814062789066;12404.75190496185;12448.75102497945;12462.43919023646;12467.563635272903;16284.592885177964;17062;17137.228824702917;17436.825631743774;17652.470425887244;5847.795327163529;6085.6044357117535;6166.9383306167265;6262.906056409066;6292.119103325538;900.5182227508383;939.8064458138126;976.4727047394327;993.2798720927415;1034.8758149022165;28858.567121493194;30488.08535743931;30531;30847.537286940715;31203;984.2913102566141;1017.8320577104695;1034.688995215314;1062.081299675775;1080.270817198388;16024.439144629881;16314.83685163157;16374.31577894988;16505.83494165067;16564.503064908073;221856;224507;224685;224846;224985;55078;55087;55434;55480.72259638757;55525;1283.8459384873875;1321.9405126769318;1339.2834833364104;1348.406701051554;1352.7700290950563;28945;29975.85012075013;30018.399632007673;30284.697153028188;30845.691543084282;49794.502054978984;50214;50214.74892625513;50231.24653130133;50282.24576631426;430411;435886;436172;436656;437210;27706.44587108206;27741.722582773913;28041.859790701732;28074;28268.43463130685;44641.55358446504;45922;46477.07045859131;46641.53358466372;46677.76661116809;39832;39925.2014959705;39931;40025.39961900632;41368;39416.60583394129;39966.2006759869;40316.59683403128;40566.31922342448;41032.58967410288;38045.619543804205;38390.424143638425;39408;39509.2098158041;41626.791866040476;31861.840690796398;36107.45838812472;36123.27753444969;36688.899333020054;36930.44604330883;26394.472110557297;27108.593371099054;27115;27186.320341990817;27493.17520474389 12:06:06 INFO - PROCESS | 17160 | |2;jquery.html;383.811932153245;389.7622450305314;390.0541187620021;394.2509232458327;423.56161372978954;14410.991230613836;17709.380171693978;17820.732689009674;19321.420357389285;19361;17432.825671743278;18303.54241143972;19381.806181938176;19472.12375443105;19552.413427597196;5608.6073974821675;5622.269105016342;5742.454466825666;5745.626534275259;5779.422057794208;5603.691796951166;5701.458361455655;5707.200991861143;5725.255716756816;5736.770529178828;5461.5357694595805;5582.49757521823;5607.607467477278;5609.214709940612;5609.35492418373;5428.809991650273;5588.30146231721;5600.5799565032585;5635.295588051494;5648.576356773238;5015.423226328982;5071.670341427795;5075.949240507584;5079.923801142949;5084.618653600958;18641.44075677732;19055.428337149908;22828.96511755711;22895.885520572458;23093;2383.380321116505;2459.5695753243112;2480.06997375984;2501.0996041425074;2555.2589748972778;14241.287935603179;14375.78436323456;14450.277486125757;14923.850761492355;15302;1825.4341154242095;1954.042519165613;1967.4491142480128;1976.5906541313805;1989.3435166395054;76753.61623191848;77309.61345193238;79314.60342698249;79826.60086699587;81503;9242.584083716249;9549.045095490395;9606.27952903535;10861.782764344669;10948.124150067975;13066.803997940038;15165.09009459436;15167.469138580096;15180.392784288726;15249.161296128597;7090.964545177241;7824.413169012347;8090.635921383552;8262.917370826335;8275.08974012858;7647.311741943141;7723.111842138113;7769.922300777033;7812.53124812513;8185.058718247358;6518.794023105741;6563.8359041023405;6581.506387020992;6612.86774264512;6635.435987940982;1901.7908030116675;1970.6649869522216;1974.3780709076595;1985.5929534445404;1996.5208349995896;879.4723166100289;957.1720461800493;976.8241716490958;988.9011098890197;999.1656966432964;18031.459056228334;18446.907765461354;19362.225510979686;19457;19657.213711451383;954.236610711428;959.4147569982305;971.4705485510414;1049.679847646475;1067.7971185474735;10335.640916702101;10956.780864382827;11005.944970275097;11028.28316159447;11114.277571957797;429543;437164;438700;443139;444104.1332313389;76646;77983;78018.6099069501;78202.60898695583;82864.58567707123;987.4914419074182;1024.3137098144261;1033.0805583031108;1034.1468288661733;1038.0864838941684;16081.678366432372;17162.313507459563;17568.472945811645;17760.3783867564;17834.821651783317;41167.794161029;41175.794121029205;41909.161816764106;41937.37093943532;43179;55776.72111639416;57818;59002;59051.409485904594;59472.107918380396;7862.2923936845955;8280.792980175303;8326.333893288644;8359.916400835913;8711.956440217758;11360.602378916697;12983.41574629125;12987.350632468528;13002.544910928073;13311.267880266678;10950.56197752081;11368.090552755924;11425.60010399632;11622.88377116218;11702.063834893359;10791.946040269748;11127.609048868891;11354;11485.712857178638;11645.6506304811;10893.564257429614;11383.715407114889;11523.193376463567;11669.183157178915;11711.063114950613;8464.957675211585;8556.401051926305;8657.22085012352;8754.562271886252;8834.116588341114;10339.121174700234;10808.89191108079;11092.500837462172;11396.145289103184;11749.76500470003 12:06:06 INFO - PROCESS | 17160 | |3;mootools.html;1419.2265215457578;1465.5969608357702;1537.5387383784862;1662.3516828436905;1696.9575760605983;7296.379807716337;7571.053618297713;7780.5720685362285;8236.17638236176;8243.340532757373;7943.602819859013;8292.460990035659;8314.75055748327;8500.404971651988;8508.319334453245;2311.884405779713;2348.0607756897293;2357.1396440299254;2358.41039740065;2360.5868972929757;2279.589673858705;2318.976810231893;2327.0808030827898;2345.870977096259;2352.4236562042324;2272.5114100468395;2292.32376448948;2314.3057082875152;2326.674265602817;2327.8486898351553;2255.560165767676;2275.7838005389463;2279.5213005268915;2282.429392651829;2287.3709729824263;2235.4523141830355;2258.2096266306826;2273.761255068227;2280.8859557022247;2284.885755712208;8333.208345207195;8388.706395276196;8450.19723126302;8453.196946290092;8467.788305292355;4975.875603109915;5053.267276244924;5069;5091.465396133427;5102.617303702237;3045.847707614633;3115.750739940799;3318.5685860837934;3327.9833600832085;3355.2786150977413;1091.4651820607924;1106.2201148190586;1136.8124259497256;1151.3437340715795;1154.9307041577533;11364.090872730245;11416.143789215843;11425.542978280859;11463.02564282037;11515.19393642437;4231.196072746168;4439.245328294198;4448.508835052381;4473.977630111894;4532.9546704533195;9110.088991100969;9128.771780705536;9183.816323673489;9200.033996430413;9227.44635321883;4994.650374473825;4997.625178111583;4999.0501804657;5003.5997120230295;5018.648694591417;4575.290829921368;4592.954070459253;4715.151272770934;4766.880827979328;4805.831795887128;3580.838862251205;3634.327649384872;3679.79761113136;3692.372296709566;3709.7217708671956;1112.410422476089;1114.2144787924494;1117.3686866920164;1139.8689150747605;1148.8449059377044;814.450246083891;894.4990805149138;917.5043880644636;930.4975313330725;965.034965034965;5499.532539734088;5598.720063996784;5670.524672234801;5709.514691251207;5722.170285308607;464.42875263426174;470.2663844402743;475.8715146910384;476.3474040564449;478.17514786992854;3803.3724435468393;3850.2684489947383;3889.669378102893;3918.941215881764;3993.4808474898077;9650.71047868565;10033.397996120257;10039.799204015879;10045.447500387549;10165.339252948535;9828.361156524803;9907.405555666683;10150.187984961185;10153.086222240034;10170.491475426199;7626.69493220276;7633.122190948001;7696.615169241515;7698.615069246515;7707.614619269014;5403.729813509387;5413.375987203744;5493.09363954943;5514.696691681996;5524.613277070566;9085.182333590008;9205.447673139364;9276.489793061177;9327.906720932975;9361.110694484014;9400.81198376015;9543.713688589354;9614.71155865325;9622.759431014281;9693.6122555097;6607.108040414482;6812.455003599601;6992.580445173306;7187.353138217585;7343.632818359168;8100.878486822585;8209.220124088202;8210.850480932555;8233.876491852507;8259.42184047111;7252.078199277301;7292.562446253241;7477.813054673677;7520.323170914644;7640.9617951912105;7121.323474269936;7254;7301.342879140902;7341.816454588678;7514.098308203051;6333.96833015832;6443.742250309935;6452.741890324334;6464.288928217987;6478.481721462366;4732.19552676039;4819.734914579732;4893.828715994923;4901.387326584177;5107.131787596043;4937.802487900587;4957.405111386656;5006.574441172541;5064.18972964324;5094.898102038012 12:06:06 INFO - PROCESS | 17160 | |4;prototype.html;329.62345367820996;336.789506558401;343.9800990064458;344.5142349287505;348.33120408815074;5259.6055295852775;5372.274742909706;5406.189071639256;5455.809046683362;5455.863603409912;5203.606341083097;5365.704886231256;5407.864803379917;5418.810341638044;5437.32033495813;4281.293586558214;4292.763897985609;4309.82760689572;4312.504062032859;4342.999999999992;4145.854895078673;4234.534201237861;4287.914241715163;4316.352547117926;4330.97834510827;4225.809838557257;4243.787810609472;4245.363195520666;4246.787660616972;4255.085156691311;4208.957910420887;4216.430781844442;4230.830766769325;4256.297710877701;4272.786360681954;3533.505309256706;3659.414493681025;3665.9185540265685;3681.650243226889;3792.2984247914223;5213.43596920926;5222.817201397971;5223.973880130613;5240.3187585614005;5241.79032838686;4707.835225767081;4727.976360118212;4759.833405830779;4776.665633405663;4786.832460863853;5411.377691565481;5551.583631227674;5601.915971260434;5605.747741351649;5612.793249451388;3989.2819292527333;3999.1801680655394;4001.4397984282223;4005.499312585927;4030.4760381150263;5779.913301300442;5795.536357091422;5823.272090988627;5880;5899.2244963223575;4002.7398219115667;4105.445764821711;4107.199096176217;4127.855525056609;4156.732196680042;4113.6297733203555;4122.319817230184;4132.648724858421;4149.419081328617;4194.433751443577;4754.5007774183905;4762.690425122356;4765.428148622187;4774.326377228763;4778.283257511401;5523.8066667666435;5627.8874422512135;5631.451350878459;5662.159798065562;5692.69068114336;1376.7815483297354;1392.4221448098926;1408.521102825024;1409.9929500352432;1414;945.479986007693;977.7848873247874;977.9217662586976;978.5107446276861;993.7068564773409;5184.948150518522;5213.530782229617;5233.371995360581;5250.763715632729;5256.9737151314;5564.582656300794;5596.496315331639;5648.446677163731;5662.913712026955;5704.629199102045;5098.388193416739;5299;5351.491608297206;5364.8122315718765;5373;2993.6407631084408;2994.2664047308112;3001.429728351606;3008.2028262510453;3016.894408695685;5757.625754325955;5763.193152958589;5763.279590051244;5781.88436231273;5794.246747922827;5568.387477377485;5941.405859414024;5964.403559644088;5965.55258355625;5968.582199246011;6042.226640953598;6043.667598282049;6050.818475445743;6079.270487541435;6087.604305720114;5645.633033852787;5750.079987202028;5821.592488525932;5833.183354330482;5884.823455296348;5747.281589801275;5773.336066352424;5777.16231146473;5790.247267855152;5790.62360946554;5821.679807610452;6046.5767396281835;6079.939200607937;6093.465789841793;6094.695265236809;4152.792360381908;4155.522114956819;4166.812493437863;4170.791460427027;4176.4570605821045;5679.346875109415;5821.417858214145;5829.300483941955;5835.270591176103;5841.093481475581;5672.631278966854;5685.630434021776;5713.114467257582;5720.427957204246;5740.799072032459;5702.6863522506665;5703.486686198262;5720.713964301852;5720.771169153354;5750.971245143747;5531.585131115263;5589.80435684749;5594.720263986866;5639.154126881001;5666.34836993751;5690.260266165372;5697.287839020122;5716.142578613241;5738;5766.94233057664;5439.836804895859;5570.604640004837;5604.607677462538;5655.830325090089;5664.745086471201 12:06:06 INFO - PROCESS | 17160 | |5;yui.html;743.8028922335582;771.2981187119722;784.4665627373388;810.6635746165342;837.3677873205729;13735.79396309055;13809.102408343451;13918.30408479577;13951.232682202488;13982.720345593094;13606.319684015785;13812.585622431317;13821.308934553257;13844.030917835755;13855.653608659788;761.3870833978659;773.8877862709903;796.24356860982;797.1271457753779;801.6192308653372;797.8603744344746;798.66456088443;799.856025915335;800.219785708935;801.4870482890955;827.1273806134526;831.094107422912;831.3432388413177;834.678648720241;835.5655059369125;827.4828232354748;827.6192951242406;827.9586020699002;828.9212524810193;829.1169904052165;588.9793857214977;601.2454369765959;605.1376788076973;605.452065880379;605.494412165842;12560.120791544596;12605.432755525931;12618.369081545978;12634.81047784284;12647.810282845672;12539;12580.68548286291;12665.366731663473;13079.607611771662;13524.661883452894;11936.641900742992;12195.329256890867;12259.855413987349;12412.81380779289;12609.18040327385;4342.696011279212;4364.10535840152;4414.646828253732;4416.403785488982;4613;61647;62770;63723.999999999534;65386.3461365385;65419.67290163519;10197.034530799143;10261.7434564135;10362.689119326433;10394.116500097576;10510.106640935453;18300.359487417878;18443;18461.1692473839;18674.439766807016;18679.90660046691;7405.1484079330485;7475.6262186890435;7654.196309387546;7706.344960678405;7903.446758726949;4283.443152390231;4336.934945975813;4341.500727416387;4347.760873151944;4373.081652852873;3133.122725636825;3173.3494633600058;3275.4595491743594;3281.2125089978235;3289.4407950648447;562.5780664501624;564.136870588001;567.1577707104946;574.787328688388;593.7239183779564;596.3529570416147;604.5465900574569;615.4338009031702;670.9496787740939;676.5669971218424;8654.663240924914;8677.56612169389;8781.604827782765;8905.777355566033;9144.497052662167;658.3376232526858;661.3485716569176;678.6165816313767;693.8959156126622;697.1181455458849;4081.4898137732785;4279;4433.778311084433;4551.13528429604;4680.853190968167;55482.44517554773;56052.43947560554;84462.15537844543;88438.11561884299;91273.54363228274;60532;65097.67451162809;68415.31584684188;77893.2210677886;77996.66010019708;61566.692166539775;63069.369306307264;63167.157477913606;63876;64165;9210.355275130676;9937.354071985297;10009.54957026921;10096.646617368357;10117.443540605043;41702.37446438367;42334;42363.788181058895;42636.57363426326;44095.77952110219;54614;57600.71199643975;57894.710526448784;58707.70646146742;59467.702661486415;12070.517179312728;12134.058550631857;12299.69250768738;12312;12989.220646761225;12736.235825850108;13763.243021633907;13764.793528097287;14094.50669226572;14174.440136422418;12189.390530473263;12467.416399791537;12836.935815320863;12877;13299.800502992657;12142.75714485723;12384.195027323196;12384.256944582994;12981.156224845356;13081.934590326988;12445.62663120108;12884.742305154032;13108;13194.736105278032;13200.537981170613;10398.67720007332;10860.076893464144;10902;11005.944970275097;11169.218154729091;9806.950965245129;9862.211023118276;10600.522976466233;10733.838992415276;11383.54465821358 12:06:06 INFO - PROCESS | 17160 | __end_tp_report 12:06:06 INFO - PROCESS | 17160 | __start_cc_report 12:06:06 INFO - PROCESS | 17160 | _x_x_mozilla_cycle_collect,323 12:06:06 INFO - PROCESS | 17160 | __end_cc_report 12:06:06 INFO - PROCESS | 17160 | __startTimestamp1478549166252__endTimestamp 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | ------- Summary: start ------- 12:06:06 INFO - PROCESS | 17160 | Number of tests: 6 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | [#0] dojo.html Cycles:165 Average:5301.76 Median:5505.06 stddev:600.67 (10.9%) stddev-sans-first:576.61 12:06:06 INFO - PROCESS | 17160 | Values: 3077.5 3082.8 3089.1 3098.2 3117.4 5138.7 5253.3 5264.6 5323.1 5406.7 5195.9 5207.0 5264.2 5270.8 5341.9 4872.3 4908.9 4913.0 4963.9 4970.1 4905.0 4911.6 4919.4 4941.7 5074.0 5016.2 5026.9 5036.2 5037.7 5041.9 4743.5 4789.4 4865.1 4886.5 4939.3 4796.9 4825.2 4841.6 4845.3 4914.2 5293.6 5305.9 5371.7 5377.4 5399.5 5683.3 5711.3 5712.7 5760.2 5775.9 5758.9 5815.0 5815.1 5819.9 5863.7 5406.2 5438.6 5442.2 5443.5 5461.4 5609.3 5640.4 5745.9 5783.7 5912.7 5617.8 5627.7 5631.8 5655.0 5677.2 5723.1 5733.3 5734.7 5740.7 5742.4 5523.1 5597.8 5618.7 5650.4 5693.7 5652.8 5675.7 5712.3 5716.3 5721.6 4312.4 4320.0 4327.8 4344.5 4360.2 3800.3 3810.2 3833.3 3894.7 3914.9 5370.3 5472.4 5508.1 5528.0 5575.2 5736.8 5779.2 5788.2 5798.9 5803.2 5372.9 5498.4 5513.3 5525.5 5528.6 4700.1 4738.9 4772.9 4780.9 4854.6 5913.5 5939.5 5962.3 5987.3 5990.2 5744.4 5780.5 5781.6 5781.6 5784.8 5577.7 5758.6 5769.9 5829.2 5878.3 5475.7 5567.7 5578.7 5579.5 5582.8 5614.2 5615.1 5622.4 5622.9 5643.4 5465.4 5499.7 5502.9 5505.8 5516.6 5487.8 5500.9 5502.4 5508.8 5541.7 5413.4 5450.4 5454.8 5470.6 5478.5 5510.8 5573.4 5618.6 5636.1 5678.2 5504.8 5505.1 5522.5 5541.4 5543.2 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | [#1] ext.html Cycles:180 Average:49976.59 Median:40356.50 stddev:89675.08 (222.2%) stddev-sans-first:89849.92 12:06:06 INFO - PROCESS | 17160 | Values: 572.2 582.2 589.5 591.1 623.6 36917.3 40548.8 40922.2 40935.6 40942.0 39894.0 40507.6 40754.8 40794.6 40918.0 8511.5 8553.7 8661.7 8670.1 8675.0 8475.1 8489.1 8564.1 8564.9 8577.2 8590.4 8598.2 8603.9 8626.0 8640.4 8550.3 8569.8 8591.9 8594.4 8619.9 8456.7 8477.7 8507.0 8530.0 8542.9 39758.6 40027.0 40088.0 40396.4 40489.4 3480.1 3520.2 3535.8 3643.1 3710.4 30889.4 31040.2 31272.7 31315.8 31398.2 4115.4 4191.1 4244.0 4272.2 4347.6 322464.0 327048.0 327528.0 327993.0 330895.0 55946.0 56060.0 56073.1 56286.7 56412.2 59031.7 59258.4 59385.7 59493.4 59832.7 15734.2 16048.7 16053.1 16090.0 16103.8 12395.8 12404.8 12448.8 12462.4 12467.6 16284.6 17062.0 17137.2 17436.8 17652.5 5847.8 6085.6 6166.9 6262.9 6292.1 900.5 939.8 976.5 993.3 1034.9 28858.6 30488.1 30531.0 30847.5 31203.0 984.3 1017.8 1034.7 1062.1 1080.3 16024.4 16314.8 16374.3 16505.8 16564.5 221856.0 224507.0 224685.0 224846.0 224985.0 55078.0 55087.0 55434.0 55480.7 55525.0 1283.8 1321.9 1339.3 1348.4 1352.8 28945.0 29975.9 30018.4 30284.7 30845.7 49794.5 50214.0 50214.7 50231.2 50282.2 430411.0 435886.0 436172.0 436656.0 437210.0 27706.4 27741.7 28041.9 28074.0 28268.4 44641.6 45922.0 46477.1 46641.5 46677.8 39832.0 39925.2 39931.0 40025.4 41368.0 39416.6 39966.2 40316.6 40566.3 41032.6 38045.6 38390.4 39408.0 39509.2 41626.8 31861.8 36107.5 36123.3 36688.9 36930.4 26394.5 27108.6 27115.0 27186.3 27493.2 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | [#2] jquery.html Cycles:180 Average:27094.23 Median:392.15 stddev:72291.52 (18434.5%) stddev-sans-first:72466.50 12:06:06 INFO - PROCESS | 17160 | Values: 383.8 389.8 390.1 394.3 423.6 14411.0 17709.4 17820.7 19321.4 19361.0 17432.8 18303.5 19381.8 19472.1 19552.4 5608.6 5622.3 5742.5 5745.6 5779.4 5603.7 5701.5 5707.2 5725.3 5736.8 5461.5 5582.5 5607.6 5609.2 5609.4 5428.8 5588.3 5600.6 5635.3 5648.6 5015.4 5071.7 5075.9 5079.9 5084.6 18641.4 19055.4 22829.0 22895.9 23093.0 2383.4 2459.6 2480.1 2501.1 2555.3 14241.3 14375.8 14450.3 14923.9 15302.0 1825.4 1954.0 1967.4 1976.6 1989.3 76753.6 77309.6 79314.6 79826.6 81503.0 9242.6 9549.0 9606.3 10861.8 10948.1 13066.8 15165.1 15167.5 15180.4 15249.2 7091.0 7824.4 8090.6 8262.9 8275.1 7647.3 7723.1 7769.9 7812.5 8185.1 6518.8 6563.8 6581.5 6612.9 6635.4 1901.8 1970.7 1974.4 1985.6 1996.5 879.5 957.2 976.8 988.9 999.2 18031.5 18446.9 19362.2 19457.0 19657.2 954.2 959.4 971.5 1049.7 1067.8 10335.6 10956.8 11005.9 11028.3 11114.3 429543.0 437164.0 438700.0 443139.0 444104.1 76646.0 77983.0 78018.6 78202.6 82864.6 987.5 1024.3 1033.1 1034.1 1038.1 16081.7 17162.3 17568.5 17760.4 17834.8 41167.8 41175.8 41909.2 41937.4 43179.0 55776.7 57818.0 59002.0 59051.4 59472.1 7862.3 8280.8 8326.3 8359.9 8712.0 11360.6 12983.4 12987.4 13002.5 13311.3 10950.6 11368.1 11425.6 11622.9 11702.1 10791.9 11127.6 11354.0 11485.7 11645.7 10893.6 11383.7 11523.2 11669.2 11711.1 8465.0 8556.4 8657.2 8754.6 8834.1 10339.1 10808.9 11092.5 11396.1 11749.8 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | [#3] mootools.html Cycles:180 Average:5437.33 Median:4998.34 stddev:3034.64 (60.7%) stddev-sans-first:3028.13 12:06:06 INFO - PROCESS | 17160 | Values: 1419.2 1465.6 1537.5 1662.4 1697.0 7296.4 7571.1 7780.6 8236.2 8243.3 7943.6 8292.5 8314.8 8500.4 8508.3 2311.9 2348.1 2357.1 2358.4 2360.6 2279.6 2319.0 2327.1 2345.9 2352.4 2272.5 2292.3 2314.3 2326.7 2327.8 2255.6 2275.8 2279.5 2282.4 2287.4 2235.5 2258.2 2273.8 2280.9 2284.9 8333.2 8388.7 8450.2 8453.2 8467.8 4975.9 5053.3 5069.0 5091.5 5102.6 3045.8 3115.8 3318.6 3328.0 3355.3 1091.5 1106.2 1136.8 1151.3 1154.9 11364.1 11416.1 11425.5 11463.0 11515.2 4231.2 4439.2 4448.5 4474.0 4533.0 9110.1 9128.8 9183.8 9200.0 9227.4 4994.7 4997.6 4999.1 5003.6 5018.6 4575.3 4593.0 4715.2 4766.9 4805.8 3580.8 3634.3 3679.8 3692.4 3709.7 1112.4 1114.2 1117.4 1139.9 1148.8 814.5 894.5 917.5 930.5 965.0 5499.5 5598.7 5670.5 5709.5 5722.2 464.4 470.3 475.9 476.3 478.2 3803.4 3850.3 3889.7 3918.9 3993.5 9650.7 10033.4 10039.8 10045.4 10165.3 9828.4 9907.4 10150.2 10153.1 10170.5 7626.7 7633.1 7696.6 7698.6 7707.6 5403.7 5413.4 5493.1 5514.7 5524.6 9085.2 9205.4 9276.5 9327.9 9361.1 9400.8 9543.7 9614.7 9622.8 9693.6 6607.1 6812.5 6992.6 7187.4 7343.6 8100.9 8209.2 8210.9 8233.9 8259.4 7252.1 7292.6 7477.8 7520.3 7641.0 7121.3 7254.0 7301.3 7341.8 7514.1 6334.0 6443.7 6452.7 6464.3 6478.5 4732.2 4819.7 4893.8 4901.4 5107.1 4937.8 4957.4 5006.6 5064.2 5094.9 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | [#4] prototype.html Cycles:180 Average:4749.40 Median:5409.62 stddev:1397.96 (25.8%) stddev-sans-first:1361.95 12:06:06 INFO - PROCESS | 17160 | Values: 329.6 336.8 344.0 344.5 348.3 5259.6 5372.3 5406.2 5455.8 5455.9 5203.6 5365.7 5407.9 5418.8 5437.3 4281.3 4292.8 4309.8 4312.5 4343.0 4145.9 4234.5 4287.9 4316.4 4331.0 4225.8 4243.8 4245.4 4246.8 4255.1 4209.0 4216.4 4230.8 4256.3 4272.8 3533.5 3659.4 3665.9 3681.7 3792.3 5213.4 5222.8 5224.0 5240.3 5241.8 4707.8 4728.0 4759.8 4776.7 4786.8 5411.4 5551.6 5601.9 5605.7 5612.8 3989.3 3999.2 4001.4 4005.5 4030.5 5779.9 5795.5 5823.3 5880.0 5899.2 4002.7 4105.4 4107.2 4127.9 4156.7 4113.6 4122.3 4132.6 4149.4 4194.4 4754.5 4762.7 4765.4 4774.3 4778.3 5523.8 5627.9 5631.5 5662.2 5692.7 1376.8 1392.4 1408.5 1410.0 1414.0 945.5 977.8 977.9 978.5 993.7 5184.9 5213.5 5233.4 5250.8 5257.0 5564.6 5596.5 5648.4 5662.9 5704.6 5098.4 5299.0 5351.5 5364.8 5373.0 2993.6 2994.3 3001.4 3008.2 3016.9 5757.6 5763.2 5763.3 5781.9 5794.2 5568.4 5941.4 5964.4 5965.6 5968.6 6042.2 6043.7 6050.8 6079.3 6087.6 5645.6 5750.1 5821.6 5833.2 5884.8 5747.3 5773.3 5777.2 5790.2 5790.6 5821.7 6046.6 6079.9 6093.5 6094.7 4152.8 4155.5 4166.8 4170.8 4176.5 5679.3 5821.4 5829.3 5835.3 5841.1 5672.6 5685.6 5713.1 5720.4 5740.8 5702.7 5703.5 5720.7 5720.8 5751.0 5531.6 5589.8 5594.7 5639.2 5666.3 5690.3 5697.3 5716.1 5738.0 5766.9 5439.8 5570.6 5604.6 5655.8 5664.7 12:06:06 INFO - PROCESS | 17160 | 12:06:06 INFO - PROCESS | 17160 | [#5] yui.html Cycles:180 Average:16712.08 Median:4415.53 stddev:21581.71 (488.8%) stddev-sans-first:21608.94 12:06:06 INFO - PROCESS | 17160 | Values: 743.8 771.3 784.5 810.7 837.4 13735.8 13809.1 13918.3 13951.2 13982.7 13606.3 13812.6 13821.3 13844.0 13855.7 761.4 773.9 796.2 797.1 801.6 797.9 798.7 799.9 800.2 801.5 827.1 831.1 831.3 834.7 835.6 827.5 827.6 828.0 828.9 829.1 589.0 601.2 605.1 605.5 605.5 12560.1 12605.4 12618.4 12634.8 12647.8 12539.0 12580.7 12665.4 13079.6 13524.7 11936.6 12195.3 12259.9 12412.8 12609.2 4342.7 4364.1 4414.6 4416.4 4613.0 61647.0 62770.0 63724.0 65386.3 65419.7 10197.0 10261.7 10362.7 10394.1 10510.1 18300.4 18443.0 18461.2 18674.4 18679.9 7405.1 7475.6 7654.2 7706.3 7903.4 4283.4 4336.9 4341.5 4347.8 4373.1 3133.1 3173.3 3275.5 3281.2 3289.4 562.6 564.1 567.2 574.8 593.7 596.4 604.5 615.4 670.9 676.6 8654.7 8677.6 8781.6 8905.8 9144.5 658.3 661.3 678.6 693.9 697.1 4081.5 4279.0 4433.8 4551.1 4680.9 55482.4 56052.4 84462.2 88438.1 91273.5 60532.0 65097.7 68415.3 77893.2 77996.7 61566.7 63069.4 63167.2 63876.0 64165.0 9210.4 9937.4 10009.5 10096.6 10117.4 41702.4 42334.0 42363.8 42636.6 44095.8 54614.0 57600.7 57894.7 58707.7 59467.7 12070.5 12134.1 12299.7 12312.0 12989.2 12736.2 13763.2 13764.8 14094.5 14174.4 12189.4 12467.4 12836.9 12877.0 13299.8 12142.8 12384.2 12384.3 12981.2 13081.9 12445.6 12884.7 13108.0 13194.7 13200.5 10398.7 10860.1 10902.0 11005.9 11169.2 9807.0 9862.2 10600.5 10733.8 11383.5 12:06:06 INFO - PROCESS | 17160 | -------- Summary: end -------- 12:06:06 INFO - PROCESS | 17160 | 12:06:07 INFO - TEST-INFO | 17160: exit 0 12:06:07 INFO - TEST-OK | dromaeo_css | took 1116305ms 12:06:07 INFO - TEST-START | kraken 12:06:07 INFO - operating with platform_type : linux_ 12:06:07 INFO - Initialising browser for kraken test... 12:06:07 INFO - TEST-INFO | started process 17519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFyISm/profile http://localhost:59784/getInfo.html) 12:06:12 INFO - PROCESS | 17519 | __metrics Screen width/height:1600/1200 12:06:12 INFO - PROCESS | 17519 | colorDepth:24 12:06:12 INFO - PROCESS | 17519 | Browser inner width/height: 1024/697 12:06:12 INFO - PROCESS | 17519 | __metrics 12:06:12 ERROR - PROCESS | 17519 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 12:06:13 INFO - TEST-INFO | 17519: exit 0 12:06:13 INFO - Browser initialized. 12:06:13 INFO - Running cycle 1/1 for kraken test... 12:06:13 INFO - TEST-INFO | started process 17645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkFyISm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:06:25 INFO - PROCESS | 17645 | RSS: Main: 186105856 12:06:25 INFO - PROCESS | 17645 | 12:06:28 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59784/tests/kraken/driver.html?testName=audio-beat-detection) 12:06:29 INFO - PROCESS | 17645 | RSS: Main: 198619136 12:06:29 INFO - PROCESS | 17645 | 12:06:32 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59784/tests/kraken/driver.html?testName=audio-dft) 12:06:33 INFO - PROCESS | 17645 | RSS: Main: 196440064 12:06:33 INFO - PROCESS | 17645 | 12:06:35 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59784/tests/kraken/driver.html?testName=audio-fft) 12:06:36 INFO - PROCESS | 17645 | RSS: Main: 192520192 12:06:36 INFO - PROCESS | 17645 | 12:06:38 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59784/tests/kraken/driver.html?testName=audio-oscillator) 12:06:39 INFO - PROCESS | 17645 | RSS: Main: 193466368 12:06:39 INFO - PROCESS | 17645 | 12:06:41 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59784/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:06:42 INFO - PROCESS | 17645 | RSS: Main: 193822720 12:06:42 INFO - PROCESS | 17645 | 12:06:45 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59784/tests/kraken/driver.html?testName=imaging-darkroom) 12:06:45 INFO - PROCESS | 17645 | RSS: Main: 194256896 12:06:45 INFO - PROCESS | 17645 | 12:06:49 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59784/tests/kraken/driver.html?testName=imaging-desaturate) 12:06:49 INFO - PROCESS | 17645 | RSS: Main: 194752512 12:06:49 INFO - PROCESS | 17645 | 12:06:52 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59784/tests/kraken/driver.html?testName=json-parse-financial) 12:06:53 INFO - PROCESS | 17645 | RSS: Main: 194441216 12:06:53 INFO - PROCESS | 17645 | 12:06:54 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59784/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:06:55 INFO - PROCESS | 17645 | RSS: Main: 194269184 12:06:55 INFO - PROCESS | 17645 | 12:06:57 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:06:57 INFO - PROCESS | 17645 | RSS: Main: 194043904 12:06:57 INFO - PROCESS | 17645 | 12:06:59 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:07:00 INFO - PROCESS | 17645 | RSS: Main: 194310144 12:07:00 INFO - PROCESS | 17645 | 12:07:03 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:07:03 INFO - PROCESS | 17645 | RSS: Main: 194383872 12:07:03 INFO - PROCESS | 17645 | 12:07:06 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:07:07 INFO - PROCESS | 17645 | RSS: Main: 195010560 12:07:07 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | Cycle 1(1): loaded http://localhost:59784/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59784/tests/kraken/driver.html?testName=ai-astar) 12:07:09 INFO - PROCESS | 17645 | RSS: Main: 196382720 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | __start_tp_report 12:07:09 INFO - PROCESS | 17645 | _x_x_mozilla_page_load 12:07:09 INFO - PROCESS | 17645 | _x_x_mozilla_page_load_details 12:07:09 INFO - PROCESS | 17645 | |i|pagename|runs| 12:07:09 INFO - PROCESS | 17645 | |0;ai-astar;105;113;113;114;115;114;115;115;113;114 12:07:09 INFO - PROCESS | 17645 | |1;audio-beat-detection;161;132;127;164;133;127;126;127;154;123 12:07:09 INFO - PROCESS | 17645 | |2;audio-dft;163;163;165;169;163;167;163;165;164;163 12:07:09 INFO - PROCESS | 17645 | |3;audio-fft;75;75;76;102;76;76;75;77;105;77 12:07:09 INFO - PROCESS | 17645 | |4;audio-oscillator;83;82;127;82;83;83;106;82;82;112 12:07:09 INFO - PROCESS | 17645 | |5;imaging-gaussian-blur;119;119;117;118;117;118;117;118;118;119 12:07:09 INFO - PROCESS | 17645 | |6;imaging-darkroom;148;147;146;148;147;148;148;147;148;147 12:07:09 INFO - PROCESS | 17645 | |7;imaging-desaturate;85;86;86;86;86;86;86;85;86;86 12:07:09 INFO - PROCESS | 17645 | |8;json-parse-financial;53;55;53;54;53;56;55;54;55;55 12:07:09 INFO - PROCESS | 17645 | |9;json-stringify-tinderbox;63;63;63;62;63;62;63;62;64;64 12:07:09 INFO - PROCESS | 17645 | |10;stanford-crypto-aes;85;87;81;91;80;80;81;79;79;80 12:07:09 INFO - PROCESS | 17645 | |11;stanford-crypto-ccm;149;133;131;132;133;143;155;159;185;130 12:07:09 INFO - PROCESS | 17645 | |12;stanford-crypto-pbkdf2;168;167;170;165;165;164;171;165;165;165 12:07:09 INFO - PROCESS | 17645 | |13;stanford-crypto-sha256-iterative;65;67;67;69;67;64;64;68;64;67 12:07:09 INFO - PROCESS | 17645 | __end_tp_report 12:07:09 INFO - PROCESS | 17645 | __start_cc_report 12:07:09 INFO - PROCESS | 17645 | _x_x_mozilla_cycle_collect,807 12:07:09 INFO - PROCESS | 17645 | __end_cc_report 12:07:09 INFO - PROCESS | 17645 | __startTimestamp1478549229315__endTimestamp 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | ------- Summary: start ------- 12:07:09 INFO - PROCESS | 17645 | Number of tests: 14 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.96 (2.6%) stddev-sans-first:0.87 12:07:09 INFO - PROCESS | 17645 | Values: 105.0 113.0 113.0 114.0 115.0 114.0 115.0 115.0 113.0 114.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:132.50 stddev:15.81 (11.9%) stddev-sans-first:14.28 12:07:09 INFO - PROCESS | 17645 | Values: 161.0 132.0 127.0 164.0 133.0 127.0 126.0 127.0 154.0 123.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.50 stddev:2.07 (1.3%) stddev-sans-first:2.12 12:07:09 INFO - PROCESS | 17645 | Values: 163.0 163.0 165.0 169.0 163.0 167.0 163.0 165.0 164.0 163.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.69 (15.4%) stddev-sans-first:12.17 12:07:09 INFO - PROCESS | 17645 | Values: 75.0 75.0 76.0 102.0 76.0 76.0 75.0 77.0 105.0 77.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.00 stddev:16.54 (20.2%) stddev-sans-first:17.21 12:07:09 INFO - PROCESS | 17645 | Values: 83.0 82.0 127.0 82.0 83.0 83.0 106.0 82.0 82.0 112.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 12:07:09 INFO - PROCESS | 17645 | Values: 119.0 119.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 119.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 12:07:09 INFO - PROCESS | 17645 | Values: 148.0 147.0 146.0 148.0 147.0 148.0 148.0 147.0 148.0 147.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 12:07:09 INFO - PROCESS | 17645 | Values: 85.0 86.0 86.0 86.0 86.0 86.0 86.0 85.0 86.0 86.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#8] json-parse-financial Cycles:10 Average:54.30 Median:55.00 stddev:1.06 (1.9%) stddev-sans-first:1.01 12:07:09 INFO - PROCESS | 17645 | Values: 53.0 55.0 53.0 54.0 53.0 56.0 55.0 54.0 55.0 55.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 12:07:09 INFO - PROCESS | 17645 | Values: 63.0 63.0 63.0 62.0 63.0 62.0 63.0 62.0 64.0 64.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:81.00 stddev:4.03 (5.0%) stddev-sans-first:4.15 12:07:09 INFO - PROCESS | 17645 | Values: 85.0 87.0 81.0 91.0 80.0 80.0 81.0 79.0 79.0 80.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:17.62 (12.1%) stddev-sans-first:18.63 12:07:09 INFO - PROCESS | 17645 | Values: 149.0 133.0 131.0 132.0 133.0 143.0 155.0 159.0 185.0 130.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:166.00 stddev:2.42 (1.5%) stddev-sans-first:2.50 12:07:09 INFO - PROCESS | 17645 | Values: 168.0 167.0 170.0 165.0 165.0 164.0 171.0 165.0 165.0 165.0 12:07:09 INFO - PROCESS | 17645 | 12:07:09 INFO - PROCESS | 17645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:1.81 (2.7%) stddev-sans-first:1.87 12:07:09 INFO - PROCESS | 17645 | Values: 65.0 67.0 67.0 69.0 67.0 64.0 64.0 68.0 64.0 67.0 12:07:09 INFO - PROCESS | 17645 | -------- Summary: end -------- 12:07:09 INFO - PROCESS | 17645 | 12:07:10 INFO - TEST-INFO | 17645: exit 0 12:07:10 INFO - TEST-OK | kraken | took 63151ms 12:07:10 INFO - SUITE-END | took 1179s 12:07:10 INFO - Completed test suite (00:19:39) 12:07:10 INFO - javascript benchmark 12:07:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6987.251926422862, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.47682893908, 3082.7842051056437, 3089.11960091374, 3098.1944694379454, 3117.4076925384175, 5138.665986710861, 5253.317068781058, 5264.578833693305, 5323.068463018971, 5406.729663516828, 5195.922061169076, 5207.0366982108335, 5264.236685680574, 5270.81552145675, 5341.893162136755, 4872.317875497424, 4908.9263661045115, 4913.0, 4963.900721985558, 4970.055689419017, 4904.975475122619, 4911.582515486188, 4919.360483137187, 4941.678790878582, 5074.0, 5016.2224855147515, 5026.949730502684, 5036.169032109698, 5037.748112594374, 5041.873953151182, 4743.501932297094, 4789.449213340476, 4865.075635629254, 4886.51134886512, 4939.259111133323, 4796.880077998078, 4825.227963525854, 4841.564259216652, 4845.3216549683075, 4914.238293064581, 5293.57651387888, 5305.946940530584, 5371.677699338014, 5377.354717433894, 5399.541039011689, 5683.318001839806, 5711.257536520267, 5712.685802280873, 5760.193572899798, 5775.913361299584, 5758.88482230353, 5814.97092514539, 5815.098659707752, 5819.883602327972, 5863.677497737623, 5406.162044883049, 5438.592105592096, 5442.210879422461, 5443.482869127427, 5461.42655021225, 5609.326880774333, 5640.379558248589, 5745.88508229833, 5783.681897495678, 5912.674802885796, 5617.8033768817895, 5627.71861406928, 5631.80288689902, 5655.0, 5677.233573467529, 5723.084306510938, 5733.31200255972, 5734.713264336767, 5740.655560666373, 5742.425757424224, 5523.143912693539, 5597.80407685729, 5618.719064046782, 5650.406707295675, 5693.715314234271, 5652.802151924663, 5675.659460432387, 5712.34308054579, 5716.342620598602, 5721.599488035881, 4312.37470566766, 4319.9784001080425, 4327.783610819446, 4344.522102568715, 4360.236958532308, 3800.315943130208, 3810.237952409529, 3833.2716783811543, 3894.746841455353, 3914.9038269284647, 5370.301860758154, 5472.370677372073, 5508.091164957737, 5528.0, 5575.219469274305, 5736.823951090017, 5779.162021506858, 5788.21859049023, 5798.88402231953, 5803.216565763652, 5372.892542149135, 5498.422665620133, 5513.3108361454815, 5525.530329921921, 5528.55771538284, 4700.130475861908, 4738.881527961759, 4772.880677983008, 4780.856574302777, 4854.563089321978, 5913.46778789911, 5939.46544810969, 5962.25471816023, 5987.251593550806, 5990.161377407167, 5744.425557444222, 5780.508656764054, 5781.624194427349, 5781.624194427349, 5784.82645520635, 5577.721113944205, 5758.568107391879, 5769.8557536061935, 5829.183914251923, 5878.3239927408895, 5475.72621368922, 5567.749451274622, 5578.721063946868, 5579.497845193952, 5582.7766889323975, 5614.185943038155, 5615.129654903497, 5622.409646987171, 5622.9156562652415, 5643.435656434488, 5465.398806131402, 5499.670019798665, 5502.9174562380795, 5505.779768809202, 5516.586256030733, 5487.75305111263, 5500.862478437911, 5502.394736578893, 5508.834734957958, 5541.667499950016, 5413.377461591967, 5450.400455949922, 5454.754536045808, 5470.562355011669, 5478.534324582455, 5510.8071217507195, 5573.359063707726, 5618.578606604603, 5636.098224284259, 5678.233438485751, 5504.779808807602, 5505.064139096283, 5522.530584900168, 5541.445855414427, 5543.1685247213245], "value": 5261.091226562001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.2046355565762, 582.1645938078857, 589.4842013238414, 591.0897218283843, 623.6476390839173, 36917.261654766924, 40548.79725601371, 40922.181556368894, 40935.59064409355, 40942.0, 39894.0, 40507.59492405075, 40754.7962260189, 40794.59205407945, 40918.0, 8511.489310641366, 8553.700620478285, 8661.653533858638, 8670.13298670131, 8675.0, 8475.110113438093, 8489.108643592426, 8564.057953625097, 8564.871526927102, 8577.228049475545, 8590.441621294627, 8598.22615964563, 8603.870941935877, 8626.0, 8640.351973601973, 8550.315974722007, 8569.828603427928, 8591.914080859206, 8594.441361311494, 8619.870701939475, 8456.746297611082, 8477.703280385156, 8507.0, 8529.957350213272, 8542.871856922151, 39758.60241397578, 40027.0, 40088.0, 40396.394054089214, 40489.39265911013, 3480.095175254427, 3520.2431477232517, 3535.840887160084, 3643.052806270389, 3710.350688629479, 30889.382212355627, 31040.223994400094, 31272.687273127205, 31315.84342078275, 31398.215044623837, 4115.444415003966, 4191.08576863821, 4243.978780106079, 4272.230998420283, 4347.630451411602, 322464.0, 327048.0, 327528.0, 327993.0, 330895.0, 55946.0, 56060.0, 56073.06575217875, 56286.718566406904, 56412.153817692764, 59031.70484147552, 59258.40741592615, 59385.70307148523, 59493.405065948784, 59832.70083649554, 15734.213289335716, 16048.679026419406, 16053.117078560557, 16090.0, 16103.838961610234, 12395.814062789066, 12404.75190496185, 12448.75102497945, 12462.43919023646, 12467.563635272903, 16284.592885177964, 17062.0, 17137.228824702917, 17436.825631743774, 17652.470425887244, 5847.795327163529, 6085.6044357117535, 6166.9383306167265, 6262.906056409066, 6292.119103325538, 900.5182227508383, 939.8064458138126, 976.4727047394327, 993.2798720927415, 1034.8758149022165, 28858.567121493194, 30488.08535743931, 30531.0, 30847.537286940715, 31203.0, 984.2913102566141, 1017.8320577104695, 1034.688995215314, 1062.081299675775, 1080.270817198388, 16024.439144629881, 16314.83685163157, 16374.31577894988, 16505.83494165067, 16564.503064908073, 221856.0, 224507.0, 224685.0, 224846.0, 224985.0, 55078.0, 55087.0, 55434.0, 55480.72259638757, 55525.0, 1283.8459384873875, 1321.9405126769318, 1339.2834833364104, 1348.406701051554, 1352.7700290950563, 28945.0, 29975.85012075013, 30018.399632007673, 30284.697153028188, 30845.691543084282, 49794.502054978984, 50214.0, 50214.74892625513, 50231.24653130133, 50282.24576631426, 430411.0, 435886.0, 436172.0, 436656.0, 437210.0, 27706.44587108206, 27741.722582773913, 28041.859790701732, 28074.0, 28268.43463130685, 44641.55358446504, 45922.0, 46477.07045859131, 46641.53358466372, 46677.76661116809, 39832.0, 39925.2014959705, 39931.0, 40025.39961900632, 41368.0, 39416.60583394129, 39966.2006759869, 40316.59683403128, 40566.31922342448, 41032.58967410288, 38045.619543804205, 38390.424143638425, 39408.0, 39509.2098158041, 41626.791866040476, 31861.840690796398, 36107.45838812472, 36123.27753444969, 36688.899333020054, 36930.44604330883, 26394.472110557297, 27108.593371099054, 27115.0, 27186.320341990817, 27493.17520474389], "value": 18854.395978523382, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.811932153245, 389.7622450305314, 390.0541187620021, 394.2509232458327, 423.56161372978954, 14410.991230613836, 17709.380171693978, 17820.732689009674, 19321.420357389285, 19361.0, 17432.825671743278, 18303.54241143972, 19381.806181938176, 19472.12375443105, 19552.413427597196, 5608.6073974821675, 5622.269105016342, 5742.454466825666, 5745.626534275259, 5779.422057794208, 5603.691796951166, 5701.458361455655, 5707.200991861143, 5725.255716756816, 5736.770529178828, 5461.5357694595805, 5582.49757521823, 5607.607467477278, 5609.214709940612, 5609.35492418373, 5428.809991650273, 5588.30146231721, 5600.5799565032585, 5635.295588051494, 5648.576356773238, 5015.423226328982, 5071.670341427795, 5075.949240507584, 5079.923801142949, 5084.618653600958, 18641.44075677732, 19055.428337149908, 22828.96511755711, 22895.885520572458, 23093.0, 2383.380321116505, 2459.5695753243112, 2480.06997375984, 2501.0996041425074, 2555.2589748972778, 14241.287935603179, 14375.78436323456, 14450.277486125757, 14923.850761492355, 15302.0, 1825.4341154242095, 1954.042519165613, 1967.4491142480128, 1976.5906541313805, 1989.3435166395054, 76753.61623191848, 77309.61345193238, 79314.60342698249, 79826.60086699587, 81503.0, 9242.584083716249, 9549.045095490395, 9606.27952903535, 10861.782764344669, 10948.124150067975, 13066.803997940038, 15165.09009459436, 15167.469138580096, 15180.392784288726, 15249.161296128597, 7090.964545177241, 7824.413169012347, 8090.635921383552, 8262.917370826335, 8275.08974012858, 7647.311741943141, 7723.111842138113, 7769.922300777033, 7812.53124812513, 8185.058718247358, 6518.794023105741, 6563.8359041023405, 6581.506387020992, 6612.86774264512, 6635.435987940982, 1901.7908030116675, 1970.6649869522216, 1974.3780709076595, 1985.5929534445404, 1996.5208349995896, 879.4723166100289, 957.1720461800493, 976.8241716490958, 988.9011098890197, 999.1656966432964, 18031.459056228334, 18446.907765461354, 19362.225510979686, 19457.0, 19657.213711451383, 954.236610711428, 959.4147569982305, 971.4705485510414, 1049.679847646475, 1067.7971185474735, 10335.640916702101, 10956.780864382827, 11005.944970275097, 11028.28316159447, 11114.277571957797, 429543.0, 437164.0, 438700.0, 443139.0, 444104.1332313389, 76646.0, 77983.0, 78018.6099069501, 78202.60898695583, 82864.58567707123, 987.4914419074182, 1024.3137098144261, 1033.0805583031108, 1034.1468288661733, 1038.0864838941684, 16081.678366432372, 17162.313507459563, 17568.472945811645, 17760.3783867564, 17834.821651783317, 41167.794161029, 41175.794121029205, 41909.161816764106, 41937.37093943532, 43179.0, 55776.72111639416, 57818.0, 59002.0, 59051.409485904594, 59472.107918380396, 7862.2923936845955, 8280.792980175303, 8326.333893288644, 8359.916400835913, 8711.956440217758, 11360.602378916697, 12983.41574629125, 12987.350632468528, 13002.544910928073, 13311.267880266678, 10950.56197752081, 11368.090552755924, 11425.60010399632, 11622.88377116218, 11702.063834893359, 10791.946040269748, 11127.609048868891, 11354.0, 11485.712857178638, 11645.6506304811, 10893.564257429614, 11383.715407114889, 11523.193376463567, 11669.183157178915, 11711.063114950613, 8464.957675211585, 8556.401051926305, 8657.22085012352, 8754.562271886252, 8834.116588341114, 10339.121174700234, 10808.89191108079, 11092.500837462172, 11396.145289103184, 11749.76500470003], "value": 9158.892458908816, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.2265215457578, 1465.5969608357702, 1537.5387383784862, 1662.3516828436905, 1696.9575760605983, 7296.379807716337, 7571.053618297713, 7780.5720685362285, 8236.17638236176, 8243.340532757373, 7943.602819859013, 8292.460990035659, 8314.75055748327, 8500.404971651988, 8508.319334453245, 2311.884405779713, 2348.0607756897293, 2357.1396440299254, 2358.41039740065, 2360.5868972929757, 2279.589673858705, 2318.976810231893, 2327.0808030827898, 2345.870977096259, 2352.4236562042324, 2272.5114100468395, 2292.32376448948, 2314.3057082875152, 2326.674265602817, 2327.8486898351553, 2255.560165767676, 2275.7838005389463, 2279.5213005268915, 2282.429392651829, 2287.3709729824263, 2235.4523141830355, 2258.2096266306826, 2273.761255068227, 2280.8859557022247, 2284.885755712208, 8333.208345207195, 8388.706395276196, 8450.19723126302, 8453.196946290092, 8467.788305292355, 4975.875603109915, 5053.267276244924, 5069.0, 5091.465396133427, 5102.617303702237, 3045.847707614633, 3115.750739940799, 3318.5685860837934, 3327.9833600832085, 3355.2786150977413, 1091.4651820607924, 1106.2201148190586, 1136.8124259497256, 1151.3437340715795, 1154.9307041577533, 11364.090872730245, 11416.143789215843, 11425.542978280859, 11463.02564282037, 11515.19393642437, 4231.196072746168, 4439.245328294198, 4448.508835052381, 4473.977630111894, 4532.9546704533195, 9110.088991100969, 9128.771780705536, 9183.816323673489, 9200.033996430413, 9227.44635321883, 4994.650374473825, 4997.625178111583, 4999.0501804657, 5003.5997120230295, 5018.648694591417, 4575.290829921368, 4592.954070459253, 4715.151272770934, 4766.880827979328, 4805.831795887128, 3580.838862251205, 3634.327649384872, 3679.79761113136, 3692.372296709566, 3709.7217708671956, 1112.410422476089, 1114.2144787924494, 1117.3686866920164, 1139.8689150747605, 1148.8449059377044, 814.450246083891, 894.4990805149138, 917.5043880644636, 930.4975313330725, 965.034965034965, 5499.532539734088, 5598.720063996784, 5670.524672234801, 5709.514691251207, 5722.170285308607, 464.42875263426174, 470.2663844402743, 475.8715146910384, 476.3474040564449, 478.17514786992854, 3803.3724435468393, 3850.2684489947383, 3889.669378102893, 3918.941215881764, 3993.4808474898077, 9650.71047868565, 10033.397996120257, 10039.799204015879, 10045.447500387549, 10165.339252948535, 9828.361156524803, 9907.405555666683, 10150.187984961185, 10153.086222240034, 10170.491475426199, 7626.69493220276, 7633.122190948001, 7696.615169241515, 7698.615069246515, 7707.614619269014, 5403.729813509387, 5413.375987203744, 5493.09363954943, 5514.696691681996, 5524.613277070566, 9085.182333590008, 9205.447673139364, 9276.489793061177, 9327.906720932975, 9361.110694484014, 9400.81198376015, 9543.713688589354, 9614.71155865325, 9622.759431014281, 9693.6122555097, 6607.108040414482, 6812.455003599601, 6992.580445173306, 7187.353138217585, 7343.632818359168, 8100.878486822585, 8209.220124088202, 8210.850480932555, 8233.876491852507, 8259.42184047111, 7252.078199277301, 7292.562446253241, 7477.813054673677, 7520.323170914644, 7640.9617951912105, 7121.323474269936, 7254.0, 7301.342879140902, 7341.816454588678, 7514.098308203051, 6333.96833015832, 6443.742250309935, 6452.741890324334, 6464.288928217987, 6478.481721462366, 4732.19552676039, 4819.734914579732, 4893.828715994923, 4901.387326584177, 5107.131787596043, 4937.802487900587, 4957.405111386656, 5006.574441172541, 5064.18972964324, 5094.898102038012], "value": 4325.798829980128, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.62345367820996, 336.789506558401, 343.9800990064458, 344.5142349287505, 348.33120408815074, 5259.6055295852775, 5372.274742909706, 5406.189071639256, 5455.809046683362, 5455.863603409912, 5203.606341083097, 5365.704886231256, 5407.864803379917, 5418.810341638044, 5437.32033495813, 4281.293586558214, 4292.763897985609, 4309.82760689572, 4312.504062032859, 4342.999999999992, 4145.854895078673, 4234.534201237861, 4287.914241715163, 4316.352547117926, 4330.97834510827, 4225.809838557257, 4243.787810609472, 4245.363195520666, 4246.787660616972, 4255.085156691311, 4208.957910420887, 4216.430781844442, 4230.830766769325, 4256.297710877701, 4272.786360681954, 3533.505309256706, 3659.414493681025, 3665.9185540265685, 3681.650243226889, 3792.2984247914223, 5213.43596920926, 5222.817201397971, 5223.973880130613, 5240.3187585614005, 5241.79032838686, 4707.835225767081, 4727.976360118212, 4759.833405830779, 4776.665633405663, 4786.832460863853, 5411.377691565481, 5551.583631227674, 5601.915971260434, 5605.747741351649, 5612.793249451388, 3989.2819292527333, 3999.1801680655394, 4001.4397984282223, 4005.499312585927, 4030.4760381150263, 5779.913301300442, 5795.536357091422, 5823.272090988627, 5880.0, 5899.2244963223575, 4002.7398219115667, 4105.445764821711, 4107.199096176217, 4127.855525056609, 4156.732196680042, 4113.6297733203555, 4122.319817230184, 4132.648724858421, 4149.419081328617, 4194.433751443577, 4754.5007774183905, 4762.690425122356, 4765.428148622187, 4774.326377228763, 4778.283257511401, 5523.8066667666435, 5627.8874422512135, 5631.451350878459, 5662.159798065562, 5692.69068114336, 1376.7815483297354, 1392.4221448098926, 1408.521102825024, 1409.9929500352432, 1414.0, 945.479986007693, 977.7848873247874, 977.9217662586976, 978.5107446276861, 993.7068564773409, 5184.948150518522, 5213.530782229617, 5233.371995360581, 5250.763715632729, 5256.9737151314, 5564.582656300794, 5596.496315331639, 5648.446677163731, 5662.913712026955, 5704.629199102045, 5098.388193416739, 5299.0, 5351.491608297206, 5364.8122315718765, 5373.0, 2993.6407631084408, 2994.2664047308112, 3001.429728351606, 3008.2028262510453, 3016.894408695685, 5757.625754325955, 5763.193152958589, 5763.279590051244, 5781.88436231273, 5794.246747922827, 5568.387477377485, 5941.405859414024, 5964.403559644088, 5965.55258355625, 5968.582199246011, 6042.226640953598, 6043.667598282049, 6050.818475445743, 6079.270487541435, 6087.604305720114, 5645.633033852787, 5750.079987202028, 5821.592488525932, 5833.183354330482, 5884.823455296348, 5747.281589801275, 5773.336066352424, 5777.16231146473, 5790.247267855152, 5790.62360946554, 5821.679807610452, 6046.5767396281835, 6079.939200607937, 6093.465789841793, 6094.695265236809, 4152.792360381908, 4155.522114956819, 4166.812493437863, 4170.791460427027, 4176.4570605821045, 5679.346875109415, 5821.417858214145, 5829.300483941955, 5835.270591176103, 5841.093481475581, 5672.631278966854, 5685.630434021776, 5713.114467257582, 5720.427957204246, 5740.799072032459, 5702.6863522506665, 5703.486686198262, 5720.713964301852, 5720.771169153354, 5750.971245143747, 5531.585131115263, 5589.80435684749, 5594.720263986866, 5639.154126881001, 5666.34836993751, 5690.260266165372, 5697.287839020122, 5716.142578613241, 5738.0, 5766.94233057664, 5439.836804895859, 5570.604640004837, 5604.607677462538, 5655.830325090089, 5664.745086471201], "value": 4303.845960299234, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.8028922335582, 771.2981187119722, 784.4665627373388, 810.6635746165342, 837.3677873205729, 13735.79396309055, 13809.102408343451, 13918.30408479577, 13951.232682202488, 13982.720345593094, 13606.319684015785, 13812.585622431317, 13821.308934553257, 13844.030917835755, 13855.653608659788, 761.3870833978659, 773.8877862709903, 796.24356860982, 797.1271457753779, 801.6192308653372, 797.8603744344746, 798.66456088443, 799.856025915335, 800.219785708935, 801.4870482890955, 827.1273806134526, 831.094107422912, 831.3432388413177, 834.678648720241, 835.5655059369125, 827.4828232354748, 827.6192951242406, 827.9586020699002, 828.9212524810193, 829.1169904052165, 588.9793857214977, 601.2454369765959, 605.1376788076973, 605.452065880379, 605.494412165842, 12560.120791544596, 12605.432755525931, 12618.369081545978, 12634.81047784284, 12647.810282845672, 12539.0, 12580.68548286291, 12665.366731663473, 13079.607611771662, 13524.661883452894, 11936.641900742992, 12195.329256890867, 12259.855413987349, 12412.81380779289, 12609.18040327385, 4342.696011279212, 4364.10535840152, 4414.646828253732, 4416.403785488982, 4613.0, 61647.0, 62770.0, 63723.999999999534, 65386.3461365385, 65419.67290163519, 10197.034530799143, 10261.7434564135, 10362.689119326433, 10394.116500097576, 10510.106640935453, 18300.359487417878, 18443.0, 18461.1692473839, 18674.439766807016, 18679.90660046691, 7405.1484079330485, 7475.6262186890435, 7654.196309387546, 7706.344960678405, 7903.446758726949, 4283.443152390231, 4336.934945975813, 4341.500727416387, 4347.760873151944, 4373.081652852873, 3133.122725636825, 3173.3494633600058, 3275.4595491743594, 3281.2125089978235, 3289.4407950648447, 562.5780664501624, 564.136870588001, 567.1577707104946, 574.787328688388, 593.7239183779564, 596.3529570416147, 604.5465900574569, 615.4338009031702, 670.9496787740939, 676.5669971218424, 8654.663240924914, 8677.56612169389, 8781.604827782765, 8905.777355566033, 9144.497052662167, 658.3376232526858, 661.3485716569176, 678.6165816313767, 693.8959156126622, 697.1181455458849, 4081.4898137732785, 4279.0, 4433.778311084433, 4551.13528429604, 4680.853190968167, 55482.44517554773, 56052.43947560554, 84462.15537844543, 88438.11561884299, 91273.54363228274, 60532.0, 65097.67451162809, 68415.31584684188, 77893.2210677886, 77996.66010019708, 61566.692166539775, 63069.369306307264, 63167.157477913606, 63876.0, 64165.0, 9210.355275130676, 9937.354071985297, 10009.54957026921, 10096.646617368357, 10117.443540605043, 41702.37446438367, 42334.0, 42363.788181058895, 42636.57363426326, 44095.77952110219, 54614.0, 57600.71199643975, 57894.710526448784, 58707.70646146742, 59467.702661486415, 12070.517179312728, 12134.058550631857, 12299.69250768738, 12312.0, 12989.220646761225, 12736.235825850108, 13763.243021633907, 13764.793528097287, 14094.50669226572, 14174.440136422418, 12189.390530473263, 12467.416399791537, 12836.935815320863, 12877.0, 13299.800502992657, 12142.75714485723, 12384.195027323196, 12384.256944582994, 12981.156224845356, 13081.934590326988, 12445.62663120108, 12884.742305154032, 13108.0, 13194.736105278032, 13200.537981170613, 10398.67720007332, 10860.076893464144, 10902.0, 11005.944970275097, 11169.218154729091, 9806.950965245129, 9862.211023118276, 10600.522976466233, 10733.838992415276, 11383.54465821358], "value": 6879.224237459684, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 114.0, 115.0, 114.0, 115.0, 115.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 132.0, 127.0, 164.0, 133.0, 127.0, 126.0, 127.0, 154.0, 123.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 169.0, 163.0, 167.0, 163.0, 165.0, 164.0, 163.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 102.0, 76.0, 76.0, 75.0, 77.0, 105.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 127.0, 82.0, 83.0, 83.0, 106.0, 82.0, 82.0, 112.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 85.0, 86.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 53.0, 56.0, 55.0, 54.0, 55.0, 55.0], "value": 54.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0, 62.0, 64.0, 64.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 81.0, 91.0, 80.0, 80.0, 81.0, 79.0, 79.0, 80.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 133.0, 131.0, 132.0, 133.0, 143.0, 155.0, 159.0, 185.0, 130.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 170.0, 165.0, 165.0, 164.0, 171.0, 165.0, 165.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 67.0, 69.0, 67.0, 64.0, 64.0, 68.0, 64.0, 67.0], "value": 66.2, "unit": "score"}]}]} 12:07:11 INFO - Return code: 0 12:07:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:07:11 ERROR - # TBPL SUCCESS # 12:07:11 INFO - Running post-action listener: _resource_record_post_action 12:07:11 INFO - [mozharness: 2016-11-07 20:07:11.108214Z] Finished run-tests step (success) 12:07:11 INFO - Running post-run listener: _resource_record_post_run 12:07:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 404307968; Read time: 12; Write time: 385972 12:07:11 INFO - TinderboxPrint: CPU usage
13.4% 12:07:11 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 12:07:11 INFO - TinderboxPrint: I/O write bytes / time
404,307,968 / 385,972 12:07:11 INFO - TinderboxPrint: CPU idle
8,262.1 (86.5%) 12:07:11 INFO - TinderboxPrint: CPU user
1,219.2 (12.8%) 12:07:11 INFO - TinderboxPrint: Swap in / out
0 / 0 12:07:11 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103841792; Read time: 0; Write time: 135528 12:07:11 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288628736; Read time: 0; Write time: 246748 12:07:11 INFO - Running post-run listener: _upload_blobber_files 12:07:11 INFO - Blob upload gear active. 12:07:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:07:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:07:12 INFO - (blobuploader) - INFO - Open directory for files ... 12:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:12 INFO - (blobuploader) - INFO - Done attempting. 12:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:16 INFO - (blobuploader) - INFO - Done attempting. 12:07:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:07:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:07:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:07:16 INFO - (blobuploader) - INFO - Done attempting. 12:07:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:07:16 INFO - Return code: 0 12:07:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:07:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:07:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1df15c49d0ce506d1ff7c9b983fb57dd059ad6966612148b2e852c1d1b8970758a8826c7126273506f42509e777bb102329c6a52962bd0df6bce3290be68111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47b2ca337045989f1e7ae2de2122c6d65cea473cc75a6b036463eed20b472bbb7f9cfd080897be3501565597d9de7a8d49d390cd01f7f6f8c4ab79b9dfdda8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5cc13e2e1591cecc7e800cd5687f3506dc9e35696bce655da1a04897340ed1a44e61cb9ae8627b706e1cb2be6f6b72a79b17f4e160bcc6f9c589d55696be324c"} 12:07:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:07:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:07:16 INFO - Contents: 12:07:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1df15c49d0ce506d1ff7c9b983fb57dd059ad6966612148b2e852c1d1b8970758a8826c7126273506f42509e777bb102329c6a52962bd0df6bce3290be68111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47b2ca337045989f1e7ae2de2122c6d65cea473cc75a6b036463eed20b472bbb7f9cfd080897be3501565597d9de7a8d49d390cd01f7f6f8c4ab79b9dfdda8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5cc13e2e1591cecc7e800cd5687f3506dc9e35696bce655da1a04897340ed1a44e61cb9ae8627b706e1cb2be6f6b72a79b17f4e160bcc6f9c589d55696be324c"} 12:07:16 INFO - Running post-run listener: copy_logs_to_upload_dir 12:07:16 INFO - Copying logs to upload dir... 12:07:16 INFO - mkdir: /builds/slave/test/build/upload/logs 12:07:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.305875 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-07 12:07:14.404985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 12:07:14.408154) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063 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/Mozilla-Inbound/sha512/e1df15c49d0ce506d1ff7c9b983fb57dd059ad6966612148b2e852c1d1b8970758a8826c7126273506f42509e777bb102329c6a52962bd0df6bce3290be68111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47b2ca337045989f1e7ae2de2122c6d65cea473cc75a6b036463eed20b472bbb7f9cfd080897be3501565597d9de7a8d49d390cd01f7f6f8c4ab79b9dfdda8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5cc13e2e1591cecc7e800cd5687f3506dc9e35696bce655da1a04897340ed1a44e61cb9ae8627b706e1cb2be6f6b72a79b17f4e160bcc6f9c589d55696be324c"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011455 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478539811/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e1df15c49d0ce506d1ff7c9b983fb57dd059ad6966612148b2e852c1d1b8970758a8826c7126273506f42509e777bb102329c6a52962bd0df6bce3290be68111", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/47b2ca337045989f1e7ae2de2122c6d65cea473cc75a6b036463eed20b472bbb7f9cfd080897be3501565597d9de7a8d49d390cd01f7f6f8c4ab79b9dfdda8d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5cc13e2e1591cecc7e800cd5687f3506dc9e35696bce655da1a04897340ed1a44e61cb9ae8627b706e1cb2be6f6b72a79b17f4e160bcc6f9c589d55696be324c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 12:07:14.434086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:07:14.434411) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1478547996.77053-649686063 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:07:14.518355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 12:07:14.518659) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 12:07:14.518951) ========= ========= Total master_lag: 0.15 =========