builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1476463201.19 results: success (0) buildid: 20161014093904 builduid: 55db3f78eaf944f89cd3df0365b7fd6f revision: 7b76b051ded7c2be573933c33b1c39a976b4b80b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.187552) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.188027) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.188302) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.203179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.203520) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 09:40:01-- 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% 215M=0s 2016-10-14 09:40:01 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120616 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.338168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.338493) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016508 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:01.387567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 09:40:01.387926) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7b76b051ded7c2be573933c33b1c39a976b4b80b --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 7b76b051ded7c2be573933c33b1c39a976b4b80b --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=a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 09:40:01,720 truncating revision to first 12 chars 2016-10-14 09:40:01,720 Setting DEBUG logging. 2016-10-14 09:40:01,720 attempt 1/10 2016-10-14 09:40:01,720 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7b76b051ded7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 09:40:02,414 unpacking tar archive at: mozilla-inbound-7b76b051ded7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.086378 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-14 09:40:02.488216) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:02.488717) ========= script_repo_revision: 7b76b051ded7c2be573933c33b1c39a976b4b80b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:02.489350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:02.489877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 09:40:02.501986) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-14 09:40:02.502337) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:40:02 INFO - MultiFileLogger online at 20161014 09:40:02 in /builds/slave/test 09:40:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:40:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:40:02 INFO - {'append_to_log': False, 09:40:02 INFO - 'base_work_dir': '/builds/slave/test', 09:40:02 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:40:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:40:02 INFO - 'branch': 'Mozilla-Inbound', 09:40:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:40:02 INFO - 'config_files': ('talos/linux_config.py',), 09:40:02 INFO - 'default_actions': ('clobber', 09:40:02 INFO - 'read-buildbot-config', 09:40:02 INFO - 'download-and-extract', 09:40:02 INFO - 'populate-webroot', 09:40:02 INFO - 'create-virtualenv', 09:40:02 INFO - 'install', 09:40:02 INFO - 'run-tests'), 09:40:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:40:02 INFO - 'download_minidump_stackwalk': True, 09:40:02 INFO - 'download_symbols': 'ondemand', 09:40:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:40:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:40:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:40:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:40:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:40:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:40:02 INFO - 'installer_path': 'installer.exe', 09:40:02 INFO - 'log_level': 'info', 09:40:02 INFO - 'log_name': 'talos', 09:40:02 INFO - 'log_to_console': True, 09:40:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:40:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:40:02 INFO - 'opt_config_files': (), 09:40:02 INFO - 'pip_index': False, 09:40:02 INFO - 'sps_profile': False, 09:40:02 INFO - 'sps_profile_interval': 0, 09:40:02 INFO - 'suite': 'dromaeojs', 09:40:02 INFO - 'system_bits': '32', 09:40:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:40:02 INFO - 'title': 'talos-linux64-ix-062', 09:40:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:40:02 INFO - 'use_talos_json': True, 09:40:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:40:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:40:02 INFO - 'work_dir': 'build'} 09:40:02 INFO - [mozharness: 2016-10-14 16:40:02.937481Z] Running clobber step. 09:40:02 INFO - Running pre-action listener: _resource_record_pre_action 09:40:02 INFO - Running main action method: clobber 09:40:02 INFO - rmtree: /builds/slave/test/build 09:40:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:40:03 INFO - Running post-action listener: _resource_record_post_action 09:40:03 INFO - [mozharness: 2016-10-14 16:40:03.408802Z] Finished clobber step (success) 09:40:03 INFO - [mozharness: 2016-10-14 16:40:03.408902Z] Running read-buildbot-config step. 09:40:03 INFO - Running pre-action listener: _resource_record_pre_action 09:40:03 INFO - Running main action method: read_buildbot_config 09:40:03 INFO - Using buildbot properties: 09:40:03 INFO - { 09:40:03 INFO - "project": "", 09:40:03 INFO - "product": "firefox", 09:40:03 INFO - "script_repo_revision": "production", 09:40:03 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:40:03 INFO - "repository": "", 09:40:03 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 09:40:03 INFO - "buildid": "20161014093904", 09:40:03 INFO - "stage_platform": "linux64-pgo", 09:40:03 INFO - "basedir": "/builds/slave/test", 09:40:03 INFO - "buildnumber": 1827, 09:40:03 INFO - "platform": "ubuntu64_hw", 09:40:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:40:03 INFO - "slavebuilddir": "test", 09:40:03 INFO - "branch": "mozilla-inbound", 09:40:03 INFO - "revision": "7b76b051ded7c2be573933c33b1c39a976b4b80b", 09:40:03 INFO - "slavename": "talos-linux64-ix-062", 09:40:03 INFO - "builduid": "55db3f78eaf944f89cd3df0365b7fd6f", 09:40:03 INFO - "repo_path": "integration/mozilla-inbound" 09:40:03 INFO - } 09:40:03 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:40:03 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 09:40:03 INFO - Running post-action listener: _resource_record_post_action 09:40:03 INFO - [mozharness: 2016-10-14 16:40:03.411405Z] Finished read-buildbot-config step (success) 09:40:03 INFO - [mozharness: 2016-10-14 16:40:03.411491Z] Running download-and-extract step. 09:40:03 INFO - Running pre-action listener: _resource_record_pre_action 09:40:03 INFO - Running main action method: download_and_extract 09:40:03 INFO - mkdir: /builds/slave/test/build/tests 09:40:03 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')]} 09:40:03 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:40:03 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/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 09:40:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/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 09:40:03 INFO - Downloaded 1361 bytes. 09:40:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:40:03 INFO - Using the following test package requirements: 09:40:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:40:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:40:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:40:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'jsshell-linux-x86_64.zip'], 09:40:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:40:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:40:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:40:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:40:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:40:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:40:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:40:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:40:03 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/1476451805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:40:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:40:03 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:40:03 INFO - Http code: 200 09:40:03 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:40:03 INFO - x-amz-cf-id: x3JLNT8RA0uU00nN1Wes54kIiiZ8PhBv7leOpb5qZTlW1vGNo-9-0A== 09:40:03 INFO - x-amz-replication-status: COMPLETED 09:40:03 INFO - x-amz-version-id: qisTBoPieY.HE5rHTM0UfS5DeEcA2PsU 09:40:03 INFO - Expected file size: 22123160 09:40:03 INFO - Obtained file size: 22123160 09:40:07 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 09:40:07 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/1476451805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:40:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:40:07 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:40:07 INFO - Http code: 200 09:40:07 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 09:40:07 INFO - x-amz-cf-id: Kk_JiVFkabX_drAUvVCENC5q9EkdpF2jXSDJu2EnUOCXVS3hrmy7Sw== 09:40:07 INFO - x-amz-replication-status: COMPLETED 09:40:07 INFO - x-amz-version-id: qisTBoPieY.HE5rHTM0UfS5DeEcA2PsU 09:40:08 INFO - Expected file size: 22123160 09:40:08 INFO - Obtained file size: 22123160 09:40:13 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/1476451805/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:40:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:40:13 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:40:13 INFO - Http code: 200 09:40:13 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 09:40:13 INFO - x-amz-cf-id: pBKEPKNbNI9SLdbtcn340in0TsGo46pXWlfc95Du3HFydLngvd8t5A== 09:40:13 INFO - x-amz-replication-status: COMPLETED 09:40:13 INFO - x-amz-version-id: XzLsbyZ_lUQv7844jcpuOkkvUj.___82 09:40:13 INFO - Expected file size: 14409006 09:40:13 INFO - Obtained file size: 14409006 09:40: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')]} 09:40:13 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:40:13 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/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 09:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/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 09:40:14 INFO - Downloaded 59648738 bytes. 09:40:14 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:40:14 INFO - mkdir: /builds/slave/test/properties 09:40:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:40:14 INFO - Writing to file /builds/slave/test/properties/build_url 09:40:14 INFO - Contents: 09:40:14 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:40:14 INFO - Running post-action listener: _resource_record_post_action 09:40:14 INFO - Running post-action listener: set_extra_try_arguments 09:40:14 INFO - [mozharness: 2016-10-14 16:40:14.478920Z] Finished download-and-extract step (success) 09:40:14 INFO - [mozharness: 2016-10-14 16:40:14.479145Z] Running populate-webroot step. 09:40:14 INFO - Running pre-action listener: _resource_record_pre_action 09:40:14 INFO - Running main action method: populate_webroot 09:40:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:40:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:40:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:40:14 INFO - '--tppagecycles', 09:40:14 INFO - '7'], 09:40:14 INFO - 'tests': ['tsvgm']}}, 09:40:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:40:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:40:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:40:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:40:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:40:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['damp', 'tps']}, 09:40:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'tests': ['damp', 'tps']}, 09:40:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['dromaeo_dom']}, 09:40:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:40:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['basic_compositor_video']}, 09:40:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:40:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['a11yr', 09:40:14 INFO - 'ts_paint', 09:40:14 INFO - 'tpaint', 09:40:14 INFO - 'sessionrestore', 09:40:14 INFO - 'sessionrestore_no_auto_restore', 09:40:14 INFO - 'tabpaint']}, 09:40:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:40:14 INFO - 'ts_paint', 09:40:14 INFO - 'tpaint', 09:40:14 INFO - 'sessionrestore', 09:40:14 INFO - 'sessionrestore_no_auto_restore', 09:40:14 INFO - 'tabpaint']}, 09:40:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:40:14 INFO - 'ts_paint', 09:40:14 INFO - 'tpaint', 09:40:14 INFO - 'sessionrestore', 09:40:14 INFO - 'sessionrestore_no_auto_restore', 09:40:14 INFO - 'tabpaint']}, 09:40:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:40:14 INFO - 'ts_paint', 09:40:14 INFO - 'tpaint', 09:40:14 INFO - 'sessionrestore', 09:40:14 INFO - 'sessionrestore_no_auto_restore', 09:40:14 INFO - 'tabpaint']}, 09:40:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['a11yr', 09:40:14 INFO - 'ts_paint', 09:40:14 INFO - 'tpaint', 09:40:14 INFO - 'sessionrestore', 09:40:14 INFO - 'sessionrestore_no_auto_restore', 09:40:14 INFO - 'tabpaint']}, 09:40:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['a11yr', 09:40:14 INFO - 'ts_paint', 09:40:14 INFO - 'tpaint', 09:40:14 INFO - 'sessionrestore', 09:40:14 INFO - 'sessionrestore_no_auto_restore', 09:40:14 INFO - 'tabpaint']}, 09:40:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['tsvgx', 09:40:14 INFO - 'tsvgr_opacity', 09:40:14 INFO - 'tart', 09:40:14 INFO - 'tscrollx', 09:40:14 INFO - 'cart']}, 09:40:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:40:14 INFO - 'tsvgr_opacity', 09:40:14 INFO - 'tart', 09:40:14 INFO - 'tscrollx', 09:40:14 INFO - 'cart']}, 09:40:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'talos_options': ['--disable-e10s'], 09:40:14 INFO - 'tests': ['tp5o']}, 09:40:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'tests': ['tp5o']}, 09:40:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'talos_options': ['--disable-e10s', 09:40:14 INFO - '--xperf_path', 09:40:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:14 INFO - 'tests': ['tp5n']}, 09:40:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:40:14 INFO - 'talos_options': ['--xperf_path', 09:40:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:40:14 INFO - 'tests': ['tp5n']}}, 09:40:14 INFO - 'talos.zip': {'path': '', 09:40:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:40:14 INFO - Running post-action listener: _resource_record_post_action 09:40:14 INFO - [mozharness: 2016-10-14 16:40:14.501760Z] Finished populate-webroot step (success) 09:40:14 INFO - [mozharness: 2016-10-14 16:40:14.501847Z] Running create-virtualenv step. 09:40:14 INFO - Running pre-action listener: _resource_record_pre_action 09:40:14 INFO - Running main action method: create_virtualenv 09:40:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:40:14 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 09:40:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:40:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:40:14 INFO - Using real prefix '/usr' 09:40:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:40:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:40:17 INFO - Installing pip.................done. 09:40:17 INFO - Return code: 0 09:40:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:40:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:40:17 INFO - Reading from file tmpfile_stdout 09:40:17 INFO - Output received: 09:40:17 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) 09:40:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:40:17 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')]} 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 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')]} 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:17 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 09:40:17 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 09:40:17 INFO - Using env: {'DISPLAY': ':0', 09:40:17 INFO - 'HOME': '/home/cltbld', 09:40:17 INFO - 'LANG': 'en_US.UTF-8', 09:40:17 INFO - 'LANGUAGE': 'en_US:en', 09:40:17 INFO - 'LOGNAME': 'cltbld', 09:40:17 INFO - 'MAIL': '/var/mail/cltbld', 09:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:17 INFO - 'MOZ_NO_REMOTE': '1', 09:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:17 INFO - 'NO_EM_RESTART': '1', 09:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:17 INFO - 'PWD': '/builds/slave/test', 09:40:17 INFO - 'SHELL': '/bin/bash', 09:40:17 INFO - 'SHLVL': '1', 09:40:17 INFO - 'TERM': 'linux', 09:40:17 INFO - 'TMOUT': '86400', 09:40:17 INFO - 'USER': 'cltbld', 09:40:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:17 INFO - '_': '/tools/buildbot/bin/python'} 09:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:17 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 09:40:17 INFO - Cleaning up... 09:40:17 INFO - Return code: 0 09:40:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:40:17 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')]} 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 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')]} 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:17 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:17 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 09:40:17 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 09:40:17 INFO - Using env: {'DISPLAY': ':0', 09:40:17 INFO - 'HOME': '/home/cltbld', 09:40:17 INFO - 'LANG': 'en_US.UTF-8', 09:40:17 INFO - 'LANGUAGE': 'en_US:en', 09:40:17 INFO - 'LOGNAME': 'cltbld', 09:40:17 INFO - 'MAIL': '/var/mail/cltbld', 09:40:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:17 INFO - 'MOZ_NO_REMOTE': '1', 09:40:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:17 INFO - 'NO_EM_RESTART': '1', 09:40:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:17 INFO - 'PWD': '/builds/slave/test', 09:40:17 INFO - 'SHELL': '/bin/bash', 09:40:17 INFO - 'SHLVL': '1', 09:40:17 INFO - 'TERM': 'linux', 09:40:17 INFO - 'TMOUT': '86400', 09:40:17 INFO - 'USER': 'cltbld', 09:40:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:17 INFO - '_': '/tools/buildbot/bin/python'} 09:40:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:17 INFO - Downloading/unpacking psutil>=3.1.1 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:40:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:40:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:40:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:40:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:19 INFO - Installing collected packages: psutil 09:40:19 INFO - Running setup.py install for psutil 09:40:19 INFO - building 'psutil._psutil_linux' extension 09:40:19 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 09:40:20 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 09:40:20 INFO - building 'psutil._psutil_posix' extension 09:40:20 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 09:40:20 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 09:40:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:40:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:40:20 INFO - Successfully installed psutil 09:40:20 INFO - Cleaning up... 09:40:20 INFO - Return code: 0 09:40:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:20 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:20 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 09:40:20 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 09:40:20 INFO - Using env: {'DISPLAY': ':0', 09:40:20 INFO - 'HOME': '/home/cltbld', 09:40:20 INFO - 'LANG': 'en_US.UTF-8', 09:40:20 INFO - 'LANGUAGE': 'en_US:en', 09:40:20 INFO - 'LOGNAME': 'cltbld', 09:40:20 INFO - 'MAIL': '/var/mail/cltbld', 09:40:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:20 INFO - 'MOZ_NO_REMOTE': '1', 09:40:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:20 INFO - 'NO_EM_RESTART': '1', 09:40:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:20 INFO - 'PWD': '/builds/slave/test', 09:40:20 INFO - 'SHELL': '/bin/bash', 09:40:20 INFO - 'SHLVL': '1', 09:40:20 INFO - 'TERM': 'linux', 09:40:20 INFO - 'TMOUT': '86400', 09:40:20 INFO - 'USER': 'cltbld', 09:40:20 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:20 INFO - '_': '/tools/buildbot/bin/python'} 09:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:40:20 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 09:40:20 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 09:40:20 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 09:40:20 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 09:40:20 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 09:40:20 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 09:40:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:40:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:40:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:40:22 INFO - Installing collected packages: mozsystemmonitor 09:40:22 INFO - Running setup.py install for mozsystemmonitor 09:40:22 INFO - Successfully installed mozsystemmonitor 09:40:22 INFO - Cleaning up... 09:40:22 INFO - Return code: 0 09:40:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:40:22 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')]} 09:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:22 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')]} 09:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:22 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:22 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 09:40:22 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 09:40:22 INFO - Using env: {'DISPLAY': ':0', 09:40:22 INFO - 'HOME': '/home/cltbld', 09:40:22 INFO - 'LANG': 'en_US.UTF-8', 09:40:22 INFO - 'LANGUAGE': 'en_US:en', 09:40:22 INFO - 'LOGNAME': 'cltbld', 09:40:22 INFO - 'MAIL': '/var/mail/cltbld', 09:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:22 INFO - 'MOZ_NO_REMOTE': '1', 09:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:22 INFO - 'NO_EM_RESTART': '1', 09:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:22 INFO - 'PWD': '/builds/slave/test', 09:40:22 INFO - 'SHELL': '/bin/bash', 09:40:22 INFO - 'SHLVL': '1', 09:40:22 INFO - 'TERM': 'linux', 09:40:22 INFO - 'TMOUT': '86400', 09:40:22 INFO - 'USER': 'cltbld', 09:40:22 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:22 INFO - '_': '/tools/buildbot/bin/python'} 09:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:40:22 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 09:40:22 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 09:40:22 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 09:40:22 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 09:40:22 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 09:40:22 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 09:40:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:40:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:40:24 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 09:40:24 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 09:40:24 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 09:40:24 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 09:40:24 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 09:40:24 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 09:40:25 INFO - Downloading functools32-3.2.3-2.tar.gz 09:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:40:25 INFO - warning: no files found matching '*.txt' 09:40:25 INFO - no previously-included directories found matching 'build' 09:40:25 INFO - no previously-included directories found matching 'dist' 09:40:25 INFO - no previously-included directories found matching '.git*' 09:40:25 INFO - Installing collected packages: jsonschema, functools32 09:40:25 INFO - Running setup.py install for functools32 09:40:25 INFO - warning: no files found matching '*.txt' 09:40:25 INFO - no previously-included directories found matching 'build' 09:40:25 INFO - no previously-included directories found matching 'dist' 09:40:25 INFO - no previously-included directories found matching '.git*' 09:40:25 INFO - Successfully installed jsonschema functools32 09:40:25 INFO - Cleaning up... 09:40:25 INFO - Return code: 0 09:40:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:25 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:25 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 09:40:25 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 09:40:25 INFO - Using env: {'DISPLAY': ':0', 09:40:25 INFO - 'HOME': '/home/cltbld', 09:40:25 INFO - 'LANG': 'en_US.UTF-8', 09:40:25 INFO - 'LANGUAGE': 'en_US:en', 09:40:25 INFO - 'LOGNAME': 'cltbld', 09:40:25 INFO - 'MAIL': '/var/mail/cltbld', 09:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:25 INFO - 'MOZ_NO_REMOTE': '1', 09:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:25 INFO - 'NO_EM_RESTART': '1', 09:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:25 INFO - 'PWD': '/builds/slave/test', 09:40:25 INFO - 'SHELL': '/bin/bash', 09:40:25 INFO - 'SHLVL': '1', 09:40:25 INFO - 'TERM': 'linux', 09:40:25 INFO - 'TMOUT': '86400', 09:40:25 INFO - 'USER': 'cltbld', 09:40:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:25 INFO - '_': '/tools/buildbot/bin/python'} 09:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:40:25 INFO - Cleaning up... 09:40:25 INFO - Return code: 0 09:40:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:25 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:25 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 09:40:25 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 09:40:25 INFO - Using env: {'DISPLAY': ':0', 09:40:25 INFO - 'HOME': '/home/cltbld', 09:40:25 INFO - 'LANG': 'en_US.UTF-8', 09:40:25 INFO - 'LANGUAGE': 'en_US:en', 09:40:25 INFO - 'LOGNAME': 'cltbld', 09:40:25 INFO - 'MAIL': '/var/mail/cltbld', 09:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:25 INFO - 'MOZ_NO_REMOTE': '1', 09:40:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:25 INFO - 'NO_EM_RESTART': '1', 09:40:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:25 INFO - 'PWD': '/builds/slave/test', 09:40:25 INFO - 'SHELL': '/bin/bash', 09:40:25 INFO - 'SHLVL': '1', 09:40:25 INFO - 'TERM': 'linux', 09:40:25 INFO - 'TMOUT': '86400', 09:40:25 INFO - 'USER': 'cltbld', 09:40:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:25 INFO - '_': '/tools/buildbot/bin/python'} 09:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:25 INFO - Downloading/unpacking blobuploader==1.2.4 09:40:25 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 09:40:25 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 09:40:25 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 09:40:25 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 09:40:25 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 09:40:25 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 09:40:27 INFO - Downloading blobuploader-1.2.4.tar.gz 09:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:40:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:40:27 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 09:40:27 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 09:40:27 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 09:40:27 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 09:40:27 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 09:40:27 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 09:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:40:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:40:28 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 09:40:28 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 09:40:28 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 09:40:28 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 09:40:28 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 09:40:28 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 09:40:28 INFO - Downloading docopt-0.6.1.tar.gz 09:40:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:40:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:40:28 INFO - Running setup.py install for blobuploader 09:40:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:40:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:40:28 INFO - Running setup.py install for requests 09:40:28 INFO - Running setup.py install for docopt 09:40:29 INFO - Successfully installed blobuploader requests docopt 09:40:29 INFO - Cleaning up... 09:40:29 INFO - Return code: 0 09:40:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:29 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:29 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 09:40:29 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 09:40:29 INFO - Using env: {'DISPLAY': ':0', 09:40:29 INFO - 'HOME': '/home/cltbld', 09:40:29 INFO - 'LANG': 'en_US.UTF-8', 09:40:29 INFO - 'LANGUAGE': 'en_US:en', 09:40:29 INFO - 'LOGNAME': 'cltbld', 09:40:29 INFO - 'MAIL': '/var/mail/cltbld', 09:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:29 INFO - 'MOZ_NO_REMOTE': '1', 09:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:29 INFO - 'NO_EM_RESTART': '1', 09:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:29 INFO - 'PWD': '/builds/slave/test', 09:40:29 INFO - 'SHELL': '/bin/bash', 09:40:29 INFO - 'SHLVL': '1', 09:40:29 INFO - 'TERM': 'linux', 09:40:29 INFO - 'TMOUT': '86400', 09:40:29 INFO - 'USER': 'cltbld', 09:40:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:29 INFO - '_': '/tools/buildbot/bin/python'} 09:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:29 INFO - Running setup.py (path:/tmp/pip-JQkR_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:29 INFO - Running setup.py (path:/tmp/pip-U78oUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:29 INFO - Running setup.py (path:/tmp/pip-xwLnhf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:29 INFO - Running setup.py (path:/tmp/pip-_6SZ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:29 INFO - Running setup.py (path:/tmp/pip-YNMO_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:29 INFO - Running setup.py (path:/tmp/pip-x2aulM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:29 INFO - Running setup.py (path:/tmp/pip-tXfzqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:29 INFO - Running setup.py (path:/tmp/pip-eCmbmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:29 INFO - Running setup.py (path:/tmp/pip-1f0BwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:29 INFO - Running setup.py (path:/tmp/pip-MQk6MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:30 INFO - Running setup.py (path:/tmp/pip-kQxwkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:30 INFO - Running setup.py (path:/tmp/pip-vKLc6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:30 INFO - Running setup.py (path:/tmp/pip-HjEG08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:30 INFO - Running setup.py (path:/tmp/pip-ryyP6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:30 INFO - Running setup.py (path:/tmp/pip-Y5y1i8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:30 INFO - Running setup.py (path:/tmp/pip-yoh49Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:30 INFO - Running setup.py (path:/tmp/pip-ahxFVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:40:30 INFO - Running setup.py install for manifestparser 09:40:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:40:30 INFO - Running setup.py install for mozcrash 09:40:30 INFO - Running setup.py install for mozdebug 09:40:30 INFO - Running setup.py install for mozdevice 09:40:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:40:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:40:30 INFO - Running setup.py install for mozfile 09:40:31 INFO - Running setup.py install for mozhttpd 09:40:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Running setup.py install for mozinfo 09:40:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Running setup.py install for mozInstall 09:40:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Running setup.py install for mozleak 09:40:31 INFO - Running setup.py install for mozlog 09:40:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Running setup.py install for moznetwork 09:40:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Running setup.py install for mozprocess 09:40:31 INFO - Running setup.py install for mozprofile 09:40:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:40:31 INFO - Running setup.py install for mozrunner 09:40:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:40:32 INFO - Running setup.py install for mozscreenshot 09:40:32 INFO - Running setup.py install for moztest 09:40:32 INFO - Running setup.py install for mozversion 09:40:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:40:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:40:32 INFO - Cleaning up... 09:40:32 INFO - Return code: 0 09:40:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:32 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:32 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 09:40:32 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 09:40:32 INFO - Using env: {'DISPLAY': ':0', 09:40:32 INFO - 'HOME': '/home/cltbld', 09:40:32 INFO - 'LANG': 'en_US.UTF-8', 09:40:32 INFO - 'LANGUAGE': 'en_US:en', 09:40:32 INFO - 'LOGNAME': 'cltbld', 09:40:32 INFO - 'MAIL': '/var/mail/cltbld', 09:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:32 INFO - 'MOZ_NO_REMOTE': '1', 09:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:32 INFO - 'NO_EM_RESTART': '1', 09:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:32 INFO - 'PWD': '/builds/slave/test', 09:40:32 INFO - 'SHELL': '/bin/bash', 09:40:32 INFO - 'SHLVL': '1', 09:40:32 INFO - 'TERM': 'linux', 09:40:32 INFO - 'TMOUT': '86400', 09:40:32 INFO - 'USER': 'cltbld', 09:40:32 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:32 INFO - '_': '/tools/buildbot/bin/python'} 09:40:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:40:32 INFO - Running setup.py (path:/tmp/pip-R4Io8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:40:32 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)) 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:40:32 INFO - Running setup.py (path:/tmp/pip-wWuZQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:40:32 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)) 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:40:32 INFO - Running setup.py (path:/tmp/pip-YF9d37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:40:32 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)) 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:40:32 INFO - Running setup.py (path:/tmp/pip-cMA63R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:40:32 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)) 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:40:32 INFO - Running setup.py (path:/tmp/pip-hbbOnG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:40:32 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)) 09:40:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:40:32 INFO - Running setup.py (path:/tmp/pip-dsHn9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:40:33 INFO - Running setup.py (path:/tmp/pip-SbpJ24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:40:33 INFO - Running setup.py (path:/tmp/pip-PQZwDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:40:33 INFO - Running setup.py (path:/tmp/pip-uMoK4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:40:33 INFO - Running setup.py (path:/tmp/pip-G9C2iV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:40:33 INFO - Running setup.py (path:/tmp/pip-iuXKTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:40:33 INFO - Running setup.py (path:/tmp/pip-5T8SCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:40:33 INFO - Running setup.py (path:/tmp/pip-UygI3b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:40:33 INFO - Running setup.py (path:/tmp/pip-Wk7umJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:33 INFO - Running setup.py (path:/tmp/pip-QnRtl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:40:33 INFO - Running setup.py (path:/tmp/pip-Jt32q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:40:33 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)) 09:40:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:40:33 INFO - Running setup.py (path:/tmp/pip-1M8gC8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:40:33 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)) 09:40:33 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)) 09:40:33 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)) 09:40:33 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)) 09:40:33 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)) 09:40:33 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)) 09:40:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:40:33 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 09:40:33 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 09:40:33 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 09:40:33 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 09:40:33 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 09:40:33 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 09:40:35 INFO - Downloading blessings-1.6.tar.gz 09:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:40:35 INFO - Installing collected packages: blessings 09:40:35 INFO - Running setup.py install for blessings 09:40:35 INFO - Successfully installed blessings 09:40:35 INFO - Cleaning up... 09:40:35 INFO - Return code: 0 09:40:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:40:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:36 INFO - Reading from file tmpfile_stdout 09:40:36 INFO - Current package versions: 09:40:36 INFO - argparse == 1.2.1 09:40:36 INFO - blessings == 1.6 09:40:36 INFO - blobuploader == 1.2.4 09:40:36 INFO - docopt == 0.6.1 09:40:36 INFO - functools32 == 3.2.3-2 09:40:36 INFO - jsonschema == 2.5.1 09:40:36 INFO - manifestparser == 1.1 09:40:36 INFO - mozInstall == 1.12 09:40:36 INFO - mozcrash == 0.17 09:40:36 INFO - mozdebug == 0.1 09:40:36 INFO - mozdevice == 0.48 09:40:36 INFO - mozfile == 1.2 09:40:36 INFO - mozhttpd == 0.7 09:40:36 INFO - mozinfo == 0.9 09:40:36 INFO - mozleak == 0.1 09:40:36 INFO - mozlog == 3.4 09:40:36 INFO - moznetwork == 0.27 09:40:36 INFO - mozprocess == 0.23 09:40:36 INFO - mozprofile == 0.28 09:40:36 INFO - mozrunner == 6.12 09:40:36 INFO - mozscreenshot == 0.1 09:40:36 INFO - mozsystemmonitor == 0.3 09:40:36 INFO - moztest == 0.7 09:40:36 INFO - mozversion == 1.4 09:40:36 INFO - psutil == 3.1.1 09:40:36 INFO - requests == 1.2.3 09:40:36 INFO - wsgiref == 0.1.2 09:40:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:36 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:36 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 09:40:36 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 09:40:36 INFO - Using env: {'DISPLAY': ':0', 09:40:36 INFO - 'HOME': '/home/cltbld', 09:40:36 INFO - 'LANG': 'en_US.UTF-8', 09:40:36 INFO - 'LANGUAGE': 'en_US:en', 09:40:36 INFO - 'LOGNAME': 'cltbld', 09:40:36 INFO - 'MAIL': '/var/mail/cltbld', 09:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:36 INFO - 'MOZ_NO_REMOTE': '1', 09:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:36 INFO - 'NO_EM_RESTART': '1', 09:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:36 INFO - 'PWD': '/builds/slave/test', 09:40:36 INFO - 'SHELL': '/bin/bash', 09:40:36 INFO - 'SHLVL': '1', 09:40:36 INFO - 'TERM': 'linux', 09:40:36 INFO - 'TMOUT': '86400', 09:40:36 INFO - 'USER': 'cltbld', 09:40:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:36 INFO - '_': '/tools/buildbot/bin/python'} 09:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 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)) 09:40:36 INFO - Cleaning up... 09:40:36 INFO - Return code: 0 09:40:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:40:36 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 0x7fd1ffa4bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27268a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27f3ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', '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 09:40:36 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 09:40:36 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 09:40:36 INFO - Using env: {'DISPLAY': ':0', 09:40:36 INFO - 'HOME': '/home/cltbld', 09:40:36 INFO - 'LANG': 'en_US.UTF-8', 09:40:36 INFO - 'LANGUAGE': 'en_US:en', 09:40:36 INFO - 'LOGNAME': 'cltbld', 09:40:36 INFO - 'MAIL': '/var/mail/cltbld', 09:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:36 INFO - 'MOZ_NO_REMOTE': '1', 09:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:36 INFO - 'NO_EM_RESTART': '1', 09:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:36 INFO - 'PWD': '/builds/slave/test', 09:40:36 INFO - 'SHELL': '/bin/bash', 09:40:36 INFO - 'SHLVL': '1', 09:40:36 INFO - 'TERM': 'linux', 09:40:36 INFO - 'TMOUT': '86400', 09:40:36 INFO - 'USER': 'cltbld', 09:40:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:36 INFO - '_': '/tools/buildbot/bin/python'} 09:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:40:36 INFO - Cleaning up... 09:40:36 INFO - Return code: 0 09:40:36 INFO - Running post-action listener: _resource_record_post_action 09:40:36 INFO - Running post-action listener: _start_resource_monitoring 09:40:36 INFO - Starting resource monitoring. 09:40:36 INFO - [mozharness: 2016-10-14 16:40:36.698469Z] Finished create-virtualenv step (success) 09:40:36 INFO - [mozharness: 2016-10-14 16:40:36.699060Z] Running install step. 09:40:36 INFO - Running pre-action listener: _resource_record_pre_action 09:40:36 INFO - Running main action method: install 09:40:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:40:36 INFO - Reading from file tmpfile_stdout 09:40:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:40:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:40:36 INFO - Reading from file tmpfile_stdout 09:40:36 INFO - Output received: 09:40:36 INFO - Usage: mozinstall [options] installer 09:40:36 INFO - Options: 09:40:36 INFO - -h, --help show this help message and exit 09:40:36 INFO - -d DEST, --destination=DEST 09:40:36 INFO - Directory to install application into. [default: 09:40:36 INFO - "/builds/slave/test"] 09:40:36 INFO - --app=APP Application being installed. [default: firefox] 09:40:36 INFO - mkdir: /builds/slave/test/build/application 09:40:36 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'] 09:40:36 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 09:40:54 INFO - Reading from file tmpfile_stdout 09:40:54 INFO - Output received: 09:40:54 INFO - /builds/slave/test/build/application/firefox/firefox 09:40:54 INFO - Running post-action listener: _resource_record_post_action 09:40:54 INFO - [mozharness: 2016-10-14 16:40:54.012290Z] Finished install step (success) 09:40:54 INFO - [mozharness: 2016-10-14 16:40:54.012537Z] Running run-tests step. 09:40:54 INFO - Running pre-action listener: _resource_record_pre_action 09:40:54 INFO - Running main action method: run_tests 09:40:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:40:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:40:54 INFO - Python 2.7.3 09:40:54 INFO - Return code: 0 09:40:54 INFO - grabbing minidump binary from tooltool 09:40:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:40:54 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 0x27f0f60>, '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 0x27f1d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27f21d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:40:54 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 09:40:54 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 09:40:54 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 09:40:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:40:54 INFO - Return code: 0 09:40:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:40:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:40:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:40:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:40:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:40:54 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:40:54 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:40:54 INFO - Using env: {'DISPLAY': ':0', 09:40:54 INFO - 'HOME': '/home/cltbld', 09:40:54 INFO - 'LANG': 'en_US.UTF-8', 09:40:54 INFO - 'LANGUAGE': 'en_US:en', 09:40:54 INFO - 'LOGNAME': 'cltbld', 09:40:54 INFO - 'MAIL': '/var/mail/cltbld', 09:40:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:40:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:40:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:40:54 INFO - 'MOZ_NO_REMOTE': '1', 09:40:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:40:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:40:54 INFO - 'NO_EM_RESTART': '1', 09:40:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:40:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:40:54 INFO - 'PWD': '/builds/slave/test', 09:40:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:40:54 INFO - 'SHELL': '/bin/bash', 09:40:54 INFO - 'SHLVL': '1', 09:40:54 INFO - 'TERM': 'linux', 09:40:54 INFO - 'TMOUT': '86400', 09:40:54 INFO - 'USER': 'cltbld', 09:40:54 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463', 09:40:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:40:54 INFO - '_': '/tools/buildbot/bin/python'} 09:40:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:40:54 INFO - mozversion application_buildid: 20161014063005 09:40:54 INFO - mozversion application_changeset: 7b76b051ded7c2be573933c33b1c39a976b4b80b 09:40:54 INFO - mozversion application_display_name: Nightly 09:40:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:40:54 INFO - mozversion application_name: Firefox 09:40:54 INFO - mozversion application_remotingname: firefox 09:40:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:40:54 INFO - mozversion application_vendor: Mozilla 09:40:54 INFO - mozversion application_version: 52.0a1 09:40:54 INFO - mozversion platform_buildid: 20161014063005 09:40:54 INFO - mozversion platform_changeset: 7b76b051ded7c2be573933c33b1c39a976b4b80b 09:40:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:40:54 INFO - mozversion platform_version: 52.0a1 09:40:54 INFO - using testdate: 1476463254 09:40:54 INFO - actual date: 1476463254 09:40:54 INFO - starting webserver on 'localhost:39340' 09:40:54 INFO - SUITE-START | Running 2 tests 09:40:54 INFO - TEST-START | dromaeo_css 09:40:54 INFO - operating with platform_type : linux_ 09:40:54 INFO - Initialising browser for dromaeo_css test... 09:40:54 INFO - TEST-INFO | started process 15569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4gxRM8/profile http://localhost:39340/getInfo.html) 09:40:58 INFO - PROCESS | 15569 | __metrics Screen width/height:1600/1200 09:40:58 INFO - PROCESS | 15569 | colorDepth:24 09:40:58 INFO - PROCESS | 15569 | Browser inner width/height: 1024/697 09:40:58 INFO - PROCESS | 15569 | __metrics 09:40:58 INFO - PROCESS | 15569 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:40:58 INFO - PROCESS | 15569 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:40:59 INFO - PROCESS | 15569 | console.error: PushService: 09:40:59 INFO - PROCESS | 15569 | stateChangeProcessEnqueue: Error transitioning state 09:40:59 INFO - PROCESS | 15569 | UnknownError 09:40:59 INFO - TEST-INFO | 15569: exit 0 09:40:59 INFO - Browser initialized. 09:40:59 INFO - Running cycle 1/1 for dromaeo_css test... 09:41:00 INFO - TEST-INFO | started process 15653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4gxRM8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:12 INFO - PROCESS | 15653 | RSS: Main: 172212224 09:41:12 INFO - PROCESS | 15653 | 09:42:03 INFO - PROCESS | 15653 | 1476463323054 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] 09:44:14 INFO - PROCESS | 15653 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39340/tests/dromaeo/cssquery-ext.html) 09:44:16 INFO - PROCESS | 15653 | RSS: Main: 317448192 09:44:16 INFO - PROCESS | 15653 | 09:47:18 INFO - PROCESS | 15653 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-ext.html (next: http://localhost:39340/tests/dromaeo/cssquery-jquery.html) 09:47:19 INFO - PROCESS | 15653 | RSS: Main: 287240192 09:47:19 INFO - PROCESS | 15653 | 09:50:21 INFO - PROCESS | 15653 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39340/tests/dromaeo/cssquery-mootools.html) 09:50:22 INFO - PROCESS | 15653 | RSS: Main: 216481792 09:50:22 INFO - PROCESS | 15653 | 09:53:24 INFO - PROCESS | 15653 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39340/tests/dromaeo/cssquery-prototype.html) 09:53:24 INFO - PROCESS | 15653 | RSS: Main: 214515712 09:53:24 INFO - PROCESS | 15653 | 09:56:27 INFO - PROCESS | 15653 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39340/tests/dromaeo/cssquery-yui.html) 09:56:28 INFO - PROCESS | 15653 | RSS: Main: 217169920 09:56:28 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | Cycle 1(1): loaded http://localhost:39340/tests/dromaeo/cssquery-yui.html (next: http://localhost:39340/tests/dromaeo/cssquery-dojo.html) 09:59:31 INFO - PROCESS | 15653 | RSS: Main: 305078272 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | __start_tp_report 09:59:31 INFO - PROCESS | 15653 | _x_x_mozilla_page_load 09:59:31 INFO - PROCESS | 15653 | _x_x_mozilla_page_load_details 09:59:31 INFO - PROCESS | 15653 | |i|pagename|runs| 09:59:31 INFO - PROCESS | 15653 | |0;dojo.html;2919.6204493415853;2982.269344010717;2992.1472380371597;3041.163679988003;3041.4221297953386;5155.871103222421;5178.844634660962;5248.422673505911;5270.7364631768405;5365.624406291557;5286.867828304295;5299.867503312419;5301.045811753883;5309.787608495655;5312.389075256347;4784.330193772866;4800.1119792838435;4819.34938783265;4853.660243782919;4880.3655524781725;4857.708537487744;4878.829240976566;4900.730459824708;4901;4905.4849240829735;4781.689190202643;4800.159972004903;4826;4838.733869637169;4897.2898929655175;4852.2479015752615;4858.927116093244;4878.731669758162;4880.8047678092835;4941.802327906879;4708.128996135726;4711.976440117812;4776.188048031843;4778.1638213312535;4823.758812059418;5289.814856480005;5307.867303317409;5311.150215965466;5317.1492561190025;5411.485908838654;5613.719314034322;5673.46102120302;5677.318721753375;5677.630953987978;5682.488576028136;5436.130219164915;5563.026470367669;5653.349864765563;5701.287339082614;5772.624779389326;5289.841304760864;5310.309659744247;5338.706371149547;5344.599155063386;5348.171033489815;5841.036229022164;5850.210221620112;5853.678047707332;5855.941440585625;5859.765609375577;5299.761510732026;5399.649022813504;5586.636868603609;5605.047141985872;5615.8596035098635;5540.279763630702;5586.301712285965;5593.720313984284;5657.4908258256955;5665.235193248858;5538.390777014525;5581.10702287632;5585.888282234332;5593.328800543961;5593.720313984284;5550.944490555124;5559.833205003856;5606.523445507096;5617.129344951539;5671.858203544944;4322.502912165141;4352.412424322739;4368.453943257093;4368.890777730582;4370.453693288339;3911.413288006822;3929.901752456154;3940.6847452203756;3956.208758248362;3956.7823769692945;5351.973240133774;5384.461553844662;5390.407055223922;5400.864978375494;5402.108652072364;5661.207430959669;5686.175504551817;5687.744051517691;5693.28833895763;5698.715064246771;5362.839114826562;5375.166849138312;5382.192671099288;5387.299651045339;5400.9459905400445;4953.306537084811;4954.9009019819405;4957.429895562056;4957.702537847741;4965.4289756678445;5807.448292412214;5820.156077368758;5826.0678291474005;5882;5884.6469211847425;5705.7147142643535;5751.396103409082;5754.539636829128;5754.625949313281;5758.3090029196765;5721.771129154954;5752.482276594959;5753.568482363756;5760.279965004374;5888.911666325094;5475.4524547544925;5494.532964697885;5500.202470641814;5531.585131115263;5549.112142057252;5521.779128834802;5561.5272701820795;5594.552435805044;5597.468240517144;5601.607887448003;5363.973180134074;5449.23710680513;5449.37900450954;5449.918251226156;5510.1459273812625;5461.890762184814;5490.149026900836;5522.30971128609;5527.917081243865;5593.8321850344555;5474.452554744494;5479.917801232905;5491.835244942658;5516.503514683537;5519;5612.382637909745;5634.718264086861;5635.464630860061;5642.971785141048;5695.943040569541;5302;5319.255304257485;5447.673139611636;5500.7524661391135;5503.394626590992 09:59:31 INFO - PROCESS | 15653 | |1;ext.html;544.6073196777013;594.5837913460578;600.3366280260312;609.4332270987985;609.7134346856978;31534.526982095285;32147.03558893234;34343.82828085862;34393.140171495725;34500.482492762625;35122.8243858781;42395;44148.11703765923;44208.3368749469;47988.280175797394;8883.244924181436;9016.053314401992;9016.323775716815;9019.54902254888;9022;8188.672453101869;8845.20393164615;8934.106589341047;8938;8945.329100317469;8207.507549547017;10598.894011059869;10902.291351062195;10907.509162087725;11182.440877956069;10575.894241057567;10648.893511064907;10675.679729608124;10676.839847402218;10729.409882456463;10505.842412363821;10537.789244215073;10564.26050176488;10573.101286390665;10578.57189279445;40911.59088409108;41549.37675934833;41610;41610.37584436236;41630.1673966522;3321.319129578455;3391.220019395528;3453.9654603453896;3522.7005704515145;3631.5460567429072;31317.91919050801;31672.36655266905;31719.36561268785;31727.52408713871;31767.36465270705;4257.254980378452;4321.373400856858;4362.062156636307;4378.233809083429;4537.614302784267;314730;316084;316219;317523;317656;56440;56486;56495.435045649014;56917;57031.57810531381;60082;60084.39915600788;60112.69943650341;60198.39801602015;60259.69870150709;16437.26032328548;16625.251863666163;16628.08545529983;16660.75008874868;16685.582860428345;12822.487100515875;12914.160579562298;12922.806157907638;12941.54704585335;12944;14832.703345933236;14960.850391495946;16743.66512669764;16768;16889.493315200565;4944.008874630868;5667.149927510906;5911.4975227105315;6008.939910600925;6061.575689701678;832.9167083291622;886.601029536711;935.8034812689275;968.2060710217554;988.456349008057;28467.57298640522;29730;29957.251068723457;30507.389852202832;30540;974.6734843827255;1036.8496567997597;1062.8246339354075;1066.7333166708322;1074.8172810622214;15594;15736.842631573538;15968.361265549247;15980.280887359864;16184.19079046043;464884;466337;467714;467947;468257;54349;55499.722501388045;55649;55683.443165568635;57063.42936570581;1275.2157423184674;1305.9934700326437;1311.5868501422021;1311.9212847229196;1320.3992183556459;29316;30599.847000765745;30974;31024.22439439032;31036.53445198369;50755;51325;51765.7411712939;51804;51842.48157518377;469101;474144;478985;671839;672741;26926.922923082857;27267.181984540497;27277.454450910474;27305.863470682518;27337;45581.544184559054;45625.54374456346;45709.77145114253;45823.77088114538;45888.77055614701;39314.41028384634;39408.40887386634;39462.605373947044;39635.60364396319;41414.79292603638;39830;40161.39757903692;40519.392209117475;41558;41649.583504165785;37340.439893401075;37371.25257494889;37755.81122094372;37966.24067518579;38250.80874595609;33516.49725254172;36303.818480908485;36319.45520817137;36555.81722091373;37109.628903711695;25556;25999.090031848795;26061.218163455127;26100.8694956524;26609.334766630214 09:59:31 INFO - PROCESS | 15653 | |2;jquery.html;339.9082247793094;367.68195510883083;373.3261463059178;374.6253746253748;383.79275191396647;13870.583882483528;14106.717865642693;15452.22738863058;19052.61894762104;19285.807141928577;17713.7342939856;18206.908965455186;18221;18503.537411564717;18691.065446727676;5243.764030618612;5508.3114610673665;5557.249771280886;5566.582506312023;5567.805126820562;5342.118550439173;5437.803683189692;5443.346798384199;5482.533984611313;5494.752736126864;5439.102548079562;5443.129099344106;5449.182622606601;5453.072977593819;5455.727213639302;5271.5782737381105;5441.319835020622;5451.509364157225;5459.617826752129;5478.424765399655;4863.440704319013;4869.586085182764;4870.780814863304;4871.537203965618;4876.341693871317;21691.240806571852;22204.777952220433;22325.553488930294;22329.77670223293;22447.32658020262;2346.389938615955;2850.458412901542;2870.368518925833;2971.7325440710224;3033.8634761435787;13428.19430834153;14128.85871141296;14133.646658833508;14692;14791.038582492103;1812.6012277298973;1824.8540116790625;1866.5333666583354;1902.4387805597382;1923.144200830631;74215;75545.62227188883;77521;77822;78049.60975195144;9606.51967401641;9715.562799674031;9744.63125697679;9878.901210987799;10135.087842094246;13567.932160339134;13575.796363054562;13582.728345433035;13593.077488340054;13604.115732477358;7389.66746496409;7610.6194690265265;7831.725889593837;7866.921330786733;7900.2889739923685;7759.262870027338;7779.876665367365;7904.328132108835;7906.169852165554;8031.638576264082;3994.6404823566018;4012.3981402789814;4032.2540330039037;4119.588041195916;4174.20690068886;1731.5497970527754;1810.4206653870635;1833.5049536625036;1835.3667984545311;1878.2017642501883;807.6955716517899;809.0776514773163;813.9064007639079;818.7543736878913;877.1535468273147;16305.510834674978;17021.614985860062;17397;17528.91235543814;17899.284028638707;856.4561503445357;872.0407551693214;874.580578553421;882.8278485695228;899.5187574647532;9148.176664100263;9508.096730810563;9509.524523773784;9648.469334186546;9807.509624518745;409777;412904;416135;419980;422750;85788.57105714432;86292.99999999875;90976.54511727531;94706.99810322479;95441;1010.8584798128268;1030.1038096855634;1048.7535429174138;1055.1295181475314;1062.1927335225284;15459.304331305344;15972.087998136409;16371.59071023234;17099.743503847203;17108.657826843642;30123.849380752956;30409.087727368213;42208.36687449629;42399.788001059795;43433.565664342954;54793.72603136959;54847;56992;60866.08700869579;61410.69294653677;7926.801829954297;8349.916500834914;8353.665853365797;8539.74380768553;8582.270507006975;12443.75112497763;13312.46750129984;13525.323733813073;13650.180989140683;13697.520586779416;11493.885061149282;11569;11588.246763960316;11610;12078.939605302268;11309.604163854226;11660.416979151178;11765.058795296527;11771.646850594154;12272.38638068111;11519.366434846164;11562.248453850472;11625.88374116248;11681.591144309908;12172.817407738714;8232.464889782144;8283.792905177419;8543.871841922251;8550.230479256898;8737.956310218407;10740.248182627141;11542.59600913964;11569.479373428048;11673;11936.791693536723 09:59:31 INFO - PROCESS | 15653 | |3;mootools.html;1230.2003697596567;1395.8673925977032;1425.0950646339572;1519.4529969211083;1726.9222884970168;7746.61266936653;8531.744047678572;8769.91230087699;8808.515531645766;9036.63853445863;8807.163319484654;8944.95527522363;8949.642014319435;8956.596953137108;8967.820643587125;2300.02249044156;2327.1273272522803;2328.1851352026824;2328.5459335429596;2329.871857047862;2251.2120757734824;2273.6816845641624;2296.7358753743283;2300.804431623314;2307.3193407944614;2252.718410198725;2278.737945136306;2288.668143119247;2290.9083636654514;2294.7934685878267;2227.6324406472913;2260.3219034289727;2264.049099378265;2266.9886650566805;2267.2178098556055;2217.1265280837665;2233.7207849018873;2235.48583825721;2237.127520267097;2237.362351729749;8675.609597568124;8714.34642401816;8802.07578204292;8844.778880527974;8874.778130546723;5105.157648987913;5293.947060529384;5295.152775555931;5298.576113910916;5304.257403963448;3295.3903527847187;3454.913627159316;3510.7893526388243;3521.3485505181625;3553.6091029986683;1055.6727414501452;1090.2041509697885;1091.4215465803138;1094.5074716377583;1105.2263415609025;12185.207961482476;12205.877941220562;12253.326067066308;12285.570005049869;12291.385430728516;4182.64447521964;4419.955800442019;4451.265541185668;4558.772061396917;4566.634669226521;9318.068193180628;9324.766880827898;9331.253499720005;9339;9349.953250233706;5159.251908473326;5161;5163.845084647466;5164.612654050961;5172.094883395391;4040;4248.745075295492;4309.547497512779;4378.233809083397;4841.225403935354;3364.5794275715534;3706.8517259309865;3729.9813500932323;3778.2065766188857;3798.620137986179;1107.0866535108569;1136.8067428537167;1141.2410746853416;1147.7589706161632;1153.0314535789976;911.6809116809196;919.9632014719336;934.0123739232531;937.2033771294482;978.6672531339378;5623.240862483594;5728.05487094633;5828.94171058284;6087.634741915411;6148.754049838046;403.93133167361617;405.25635458933186;409.78076728949867;413.53683874061244;415.19037876141647;3852.6725228355344;4039.1921615676983;4073.918521629551;4110.479122724611;4195.727277726938;10784.245102842882;11100.167487438475;11112.222144449972;11134.777304453866;11229.3262404256;11078;11081.501332440059;11091.44542772858;11154.330740155616;11167.106631469464;7716.6527506262355;7944.443888927835;7972;8068.717594884269;8284.751457456287;5490.450954904478;5652.152177173457;5673.943260567342;6007.279126504847;6009.759609615567;9745.366551174435;9997.600095996078;9999.30004899679;10019.499025048573;10129.898701012895;9046.411983221069;9917.157041651251;10016.949915250378;10103.141232995278;10377.688669339932;7157.856842863218;7473;7635.618219089134;7689.577073261024;7835.570972998389;8309.335253179852;8321.875171872305;8339.124391939002;8413.663453461793;8421.452605580618;7266.636668166676;7302.817429564303;7311.122665280201;7312.670929808065;7351.742689005859;7343.082114735658;7437.575176805702;7496.587687677012;7529.472936894584;7709.4603377763015;6509.544331896722;6591.242007169237;6592.143021407186;6600.801975940537;6605.1083103780375;5006.924896126488;5038.899222015612;5052.444231134498;5068.087744206078;5326.707031113326;4905.558499734898;4928.112939670894;4993.725345105909;5096.159133743039;5117.181250999822 09:59:31 INFO - PROCESS | 15653 | |4;prototype.html;304.24091890732626;313.2747689099734;319.173341046689;322.91765599772054;324.66072953763313;5111.207762796763;5134.768935397911;5147.433782283951;5173.9482605173935;5179.643262315647;5071.79712811488;5088.491150884919;5123.462961111671;5132.692038477694;5134.512221338976;4043.97978010111;4045.4336392905016;4046.8871060458464;4055.6755459563165;4067.7424029663525;3848.7883166425836;3990.5610382857863;4036.9394459083137;4051.858184963527;4060.695447841409;3996.1208534122593;3998.260321840469;4003.5596084430836;4006.5392479864895;4024.3762216856435;3774.3770178823097;4002.2795896738576;4016.7389119707127;4020.1758639478835;4024.8591299304385;3436.7937923724658;3441.397755392821;3510.508528805969;3516.1033936346325;3521.418965870628;4949.208126699711;4959.677620954626;4963.354763880709;4967.875803104916;4971.527704868032;4273.777635629486;4513.413256276696;4524.389207456984;4530.207213737583;4532.592066713979;4900;5269.973650131725;5288.206768984644;5353.170258609922;5367.141257398836;3883.0584707646176;3886.689064874803;3886.9222615547815;3893.162969961472;3902.551206611248;5431.72354496693;5460.399356070829;5522.144067669517;5541.944580554183;5559.722013899289;3957.56466788653;3980.601939805996;3985.70107241958;3985.8405663773124;4006.838016975103;4018.4173294872667;4019.8392064317686;4024.537178224483;4029.5567487576345;4034.7579145250793;4558.931616025762;4561.3807098479565;4562.133194692998;4575.565321294472;4606.286025666027;5115.411727651368;5351.25082488452;5388.46115388458;5404.945950540444;5421.728913554307;1358.2122369025942;1361.5098564516766;1361.7072329449215;1363.4137320952086;1365.706373129782;825.8761185822175;866.7009881590841;873.6898401067657;873.7422460374205;881.5195718333396;4556.749378784199;4568.063546972862;4580.24425969718;4592.632589392841;4626.768661566975;4816.735079570587;4839.080574690868;4853.830115945925;4855.951440485621;4856.344393506902;4421.977890110593;4515.593596576324;4549.476810166807;4583.770811459413;4601.217792975202;2493.164789795439;2552.3619095226195;2572.816504407956;2596.3638908467547;2798.285662906977;5564.772431989436;5596.636218645775;5685.914711279334;5694.288213973254;5706.629069110494;5588.692621905753;5602.6918519481005;5604.719764011783;5605.523530499953;5611.354694210137;5464.535514481234;5661.915071273934;5688.800891968761;5701.771929122789;5712.400197979318;5529.180118139698;5537.723113844211;5557.110862262019;5568.972155139199;5579.581531385081;5501.174823776466;5501.367342755634;5522.30971128609;5526.972365138148;5541.863917896902;5494.423085576117;5731.713414329351;5767.971160144172;5790.334111577223;5803.680797556175;3949.92100158001;3968.1270120573427;3974.5627980922654;3984.7609143451486;3989.2819292526465;5303.734813259244;5607.495325420732;5621.4659607337235;5624.409437009219;5626.971865140812;5428.430014848384;5435.912817436608;5449.7275136243825;5465.426130256425;5467.17992301158;5394.163904594794;5405.5135037846785;5453.64551304164;5466.316710411199;5476.780928762805;5148.734003679109;5275.788968441219;5353.491418315254;5358.223057656696;5384.946150538444;5429.647072940246;5443.537299329601;5443.673379597237;5449.5640348772795;5463.836084917459;5324.547413469899;5332.253484512249;5353.357597088374;5354.54486368663;5360.865978350573 09:59:31 INFO - PROCESS | 15653 | |5;yui.html;699.821545505896;708.8086216721485;719.1334441997394;776.9106552746432;778.1792980545516;15791.447299344525;16588;16615.501534953957;16637.83362166378;16673.082980436073;14506.637334066654;15495.535133946;15621.687566248696;15626.76559851603;15707.60730981726;778.0235804065903;797.6769408389582;798.872180451128;799.4683535448919;800.4836880212259;651.8924377477734;668.1781408867097;776.7203806629609;793.5040599625235;803.3252068262658;843.6667516331046;846.475185385059;846.8052347959973;846.826400587878;847.3306088190322;833.9666413343459;838.2330167896367;838.266516797802;838.5765188579759;838.828040251747;496.97018178909383;500.2371383639942;507.6598678885119;588.6997631208072;599.7780821096222;14789.112653240732;14884.925575372163;14885.776713349309;14917.731992780627;14922.403103875831;13645.931770341183;14377.856221437862;14448.638784030378;14541.70916581673;14832.851671483255;13220.537281195113;13379.397927093305;13400;13434.462621495128;14205.573832785032;4304.096139810644;4376.606105450493;4381.868543943655;4507.414036175309;4590.6327493800745;73979.63010184915;75892.62053689752;76121.85817212747;76324.23675763227;78703;11441.141914356456;11492.367919764327;11733.237339572901;12066.69833254158;12223.877761222451;22041.559168816853;22055.33833984983;22093;22130.668039979413;22254.666180007313;8182.732423255668;8184.099749027602;8335.666573337;8352.791180220544;8689.348298877609;4509.8146318209865;4574.222382194968;4600.838970636079;4617.884552886205;4620;3424.3493736190544;3524.9823750881083;3529.576450825917;3536.0629433200224;3558.252766918976;616.2604874151036;621.6643012773143;628.0861346740481;639.268038096377;641.0320416171614;637.9872402551923;645.3933302695451;646.7606985415426;664.3190729502298;672.7847088931593;9333.486658233727;9453.952730236442;9466.958634550194;9738.951305243429;9786.895817399294;536.4742552298769;599.3467120838308;627.6767464755654;650.8633187030777;662.7382184037278;4298.505671847777;4543.727376357429;4562.703424277412;4609.285560738091;4645.651576131736;66963.66518167379;69793.65103174452;93586;115029;118473;100941.49529252453;101139;102068.48965755124;106257.34356640991;107977;90933.54533227292;91108;91791.54104229437;92348.53825730829;92657;8406.831863362577;8484.490930544187;8661.476231564682;8678.78303042429;8958.68644597436;44188.33717494176;51712.482875172274;52186.21720674269;52481.7375913118;52931.94136117333;72758.63620681863;72888;78085.60957195178;79391;81265;11533.480993355486;11910.022494376406;12247.448864801283;12325.815112773495;12326.691832704255;12060.811314843286;12068.155229133876;12446.25322480654;13066;13778.931105344409;12218.20581662189;12266;12561.183523070971;12605.93697031509;12981.415836287579;12069.215500992408;12143.696407589881;12702.809457858324;12756.234625922474;12823.230606163661;11431.828522572001;11700.2979821211;12125.333106679218;12181.939090304491;13185.40665670028;10030.699079027641;10063.597456101967;10191.776986761635;10287.125594324267;10293.228007899288;10441.68674939753;10726.302790318605;10903.182261330274;12085.75828483443;12108.939455302667 09:59:31 INFO - PROCESS | 15653 | __end_tp_report 09:59:31 INFO - PROCESS | 15653 | __start_cc_report 09:59:31 INFO - PROCESS | 15653 | _x_x_mozilla_cycle_collect,1394 09:59:31 INFO - PROCESS | 15653 | __end_cc_report 09:59:31 INFO - PROCESS | 15653 | __startTimestamp1476464371376__endTimestamp 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | ------- Summary: start ------- 09:59:31 INFO - PROCESS | 15653 | Number of tests: 6 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | [#0] dojo.html Cycles:165 Average:5257.26 Median:5449.24 stddev:588.45 (10.8%) stddev-sans-first:560.95 09:59:31 INFO - PROCESS | 15653 | Values: 2919.6 2982.3 2992.1 3041.2 3041.4 5155.9 5178.8 5248.4 5270.7 5365.6 5286.9 5299.9 5301.0 5309.8 5312.4 4784.3 4800.1 4819.3 4853.7 4880.4 4857.7 4878.8 4900.7 4901.0 4905.5 4781.7 4800.2 4826.0 4838.7 4897.3 4852.2 4858.9 4878.7 4880.8 4941.8 4708.1 4712.0 4776.2 4778.2 4823.8 5289.8 5307.9 5311.2 5317.1 5411.5 5613.7 5673.5 5677.3 5677.6 5682.5 5436.1 5563.0 5653.3 5701.3 5772.6 5289.8 5310.3 5338.7 5344.6 5348.2 5841.0 5850.2 5853.7 5855.9 5859.8 5299.8 5399.6 5586.6 5605.0 5615.9 5540.3 5586.3 5593.7 5657.5 5665.2 5538.4 5581.1 5585.9 5593.3 5593.7 5550.9 5559.8 5606.5 5617.1 5671.9 4322.5 4352.4 4368.5 4368.9 4370.5 3911.4 3929.9 3940.7 3956.2 3956.8 5352.0 5384.5 5390.4 5400.9 5402.1 5661.2 5686.2 5687.7 5693.3 5698.7 5362.8 5375.2 5382.2 5387.3 5400.9 4953.3 4954.9 4957.4 4957.7 4965.4 5807.4 5820.2 5826.1 5882.0 5884.6 5705.7 5751.4 5754.5 5754.6 5758.3 5721.8 5752.5 5753.6 5760.3 5888.9 5475.5 5494.5 5500.2 5531.6 5549.1 5521.8 5561.5 5594.6 5597.5 5601.6 5364.0 5449.2 5449.4 5449.9 5510.1 5461.9 5490.1 5522.3 5527.9 5593.8 5474.5 5479.9 5491.8 5516.5 5519.0 5612.4 5634.7 5635.5 5643.0 5695.9 5302.0 5319.3 5447.7 5500.8 5503.4 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | [#1] ext.html Cycles:180 Average:59777.59 Median:37563.53 stddev:122399.64 (325.8%) stddev-sans-first:122662.21 09:59:31 INFO - PROCESS | 15653 | Values: 544.6 594.6 600.3 609.4 609.7 31534.5 32147.0 34343.8 34393.1 34500.5 35122.8 42395.0 44148.1 44208.3 47988.3 8883.2 9016.1 9016.3 9019.5 9022.0 8188.7 8845.2 8934.1 8938.0 8945.3 8207.5 10598.9 10902.3 10907.5 11182.4 10575.9 10648.9 10675.7 10676.8 10729.4 10505.8 10537.8 10564.3 10573.1 10578.6 40911.6 41549.4 41610.0 41610.4 41630.2 3321.3 3391.2 3454.0 3522.7 3631.5 31317.9 31672.4 31719.4 31727.5 31767.4 4257.3 4321.4 4362.1 4378.2 4537.6 314730.0 316084.0 316219.0 317523.0 317656.0 56440.0 56486.0 56495.4 56917.0 57031.6 60082.0 60084.4 60112.7 60198.4 60259.7 16437.3 16625.3 16628.1 16660.8 16685.6 12822.5 12914.2 12922.8 12941.5 12944.0 14832.7 14960.9 16743.7 16768.0 16889.5 4944.0 5667.1 5911.5 6008.9 6061.6 832.9 886.6 935.8 968.2 988.5 28467.6 29730.0 29957.3 30507.4 30540.0 974.7 1036.8 1062.8 1066.7 1074.8 15594.0 15736.8 15968.4 15980.3 16184.2 464884.0 466337.0 467714.0 467947.0 468257.0 54349.0 55499.7 55649.0 55683.4 57063.4 1275.2 1306.0 1311.6 1311.9 1320.4 29316.0 30599.8 30974.0 31024.2 31036.5 50755.0 51325.0 51765.7 51804.0 51842.5 469101.0 474144.0 478985.0 671839.0 672741.0 26926.9 27267.2 27277.5 27305.9 27337.0 45581.5 45625.5 45709.8 45823.8 45888.8 39314.4 39408.4 39462.6 39635.6 41414.8 39830.0 40161.4 40519.4 41558.0 41649.6 37340.4 37371.3 37755.8 37966.2 38250.8 33516.5 36303.8 36319.5 36555.8 37109.6 25556.0 25999.1 26061.2 26100.9 26609.3 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | [#2] jquery.html Cycles:180 Average:26372.40 Median:206904.63 stddev:69034.19 (33.4%) stddev-sans-first:69200.18 09:59:31 INFO - PROCESS | 15653 | Values: 339.9 367.7 373.3 374.6 383.8 13870.6 14106.7 15452.2 19052.6 19285.8 17713.7 18206.9 18221.0 18503.5 18691.1 5243.8 5508.3 5557.2 5566.6 5567.8 5342.1 5437.8 5443.3 5482.5 5494.8 5439.1 5443.1 5449.2 5453.1 5455.7 5271.6 5441.3 5451.5 5459.6 5478.4 4863.4 4869.6 4870.8 4871.5 4876.3 21691.2 22204.8 22325.6 22329.8 22447.3 2346.4 2850.5 2870.4 2971.7 3033.9 13428.2 14128.9 14133.6 14692.0 14791.0 1812.6 1824.9 1866.5 1902.4 1923.1 74215.0 75545.6 77521.0 77822.0 78049.6 9606.5 9715.6 9744.6 9878.9 10135.1 13567.9 13575.8 13582.7 13593.1 13604.1 7389.7 7610.6 7831.7 7866.9 7900.3 7759.3 7779.9 7904.3 7906.2 8031.6 3994.6 4012.4 4032.3 4119.6 4174.2 1731.5 1810.4 1833.5 1835.4 1878.2 807.7 809.1 813.9 818.8 877.2 16305.5 17021.6 17397.0 17528.9 17899.3 856.5 872.0 874.6 882.8 899.5 9148.2 9508.1 9509.5 9648.5 9807.5 409777.0 412904.0 416135.0 419980.0 422750.0 85788.6 86293.0 90976.5 94707.0 95441.0 1010.9 1030.1 1048.8 1055.1 1062.2 15459.3 15972.1 16371.6 17099.7 17108.7 30123.8 30409.1 42208.4 42399.8 43433.6 54793.7 54847.0 56992.0 60866.1 61410.7 7926.8 8349.9 8353.7 8539.7 8582.3 12443.8 13312.5 13525.3 13650.2 13697.5 11493.9 11569.0 11588.2 11610.0 12078.9 11309.6 11660.4 11765.1 11771.6 12272.4 11519.4 11562.2 11625.9 11681.6 12172.8 8232.5 8283.8 8543.9 8550.2 8738.0 10740.2 11542.6 11569.5 11673.0 11936.8 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | [#3] mootools.html Cycles:180 Average:5661.54 Median:4916.84 stddev:3289.56 (66.9%) stddev-sans-first:3281.93 09:59:31 INFO - PROCESS | 15653 | Values: 1230.2 1395.9 1425.1 1519.5 1726.9 7746.6 8531.7 8769.9 8808.5 9036.6 8807.2 8945.0 8949.6 8956.6 8967.8 2300.0 2327.1 2328.2 2328.5 2329.9 2251.2 2273.7 2296.7 2300.8 2307.3 2252.7 2278.7 2288.7 2290.9 2294.8 2227.6 2260.3 2264.0 2267.0 2267.2 2217.1 2233.7 2235.5 2237.1 2237.4 8675.6 8714.3 8802.1 8844.8 8874.8 5105.2 5293.9 5295.2 5298.6 5304.3 3295.4 3454.9 3510.8 3521.3 3553.6 1055.7 1090.2 1091.4 1094.5 1105.2 12185.2 12205.9 12253.3 12285.6 12291.4 4182.6 4420.0 4451.3 4558.8 4566.6 9318.1 9324.8 9331.3 9339.0 9350.0 5159.3 5161.0 5163.8 5164.6 5172.1 4040.0 4248.7 4309.5 4378.2 4841.2 3364.6 3706.9 3730.0 3778.2 3798.6 1107.1 1136.8 1141.2 1147.8 1153.0 911.7 920.0 934.0 937.2 978.7 5623.2 5728.1 5828.9 6087.6 6148.8 403.9 405.3 409.8 413.5 415.2 3852.7 4039.2 4073.9 4110.5 4195.7 10784.2 11100.2 11112.2 11134.8 11229.3 11078.0 11081.5 11091.4 11154.3 11167.1 7716.7 7944.4 7972.0 8068.7 8284.8 5490.5 5652.2 5673.9 6007.3 6009.8 9745.4 9997.6 9999.3 10019.5 10129.9 9046.4 9917.2 10016.9 10103.1 10377.7 7157.9 7473.0 7635.6 7689.6 7835.6 8309.3 8321.9 8339.1 8413.7 8421.5 7266.6 7302.8 7311.1 7312.7 7351.7 7343.1 7437.6 7496.6 7529.5 7709.5 6509.5 6591.2 6592.1 6600.8 6605.1 5006.9 5038.9 5052.4 5068.1 5326.7 4905.6 4928.1 4993.7 5096.2 5117.2 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | [#4] prototype.html Cycles:180 Average:4474.03 Median:5021.66 stddev:1331.39 (26.5%) stddev-sans-first:1297.81 09:59:31 INFO - PROCESS | 15653 | Values: 304.2 313.3 319.2 322.9 324.7 5111.2 5134.8 5147.4 5173.9 5179.6 5071.8 5088.5 5123.5 5132.7 5134.5 4044.0 4045.4 4046.9 4055.7 4067.7 3848.8 3990.6 4036.9 4051.9 4060.7 3996.1 3998.3 4003.6 4006.5 4024.4 3774.4 4002.3 4016.7 4020.2 4024.9 3436.8 3441.4 3510.5 3516.1 3521.4 4949.2 4959.7 4963.4 4967.9 4971.5 4273.8 4513.4 4524.4 4530.2 4532.6 4900.0 5270.0 5288.2 5353.2 5367.1 3883.1 3886.7 3886.9 3893.2 3902.6 5431.7 5460.4 5522.1 5541.9 5559.7 3957.6 3980.6 3985.7 3985.8 4006.8 4018.4 4019.8 4024.5 4029.6 4034.8 4558.9 4561.4 4562.1 4575.6 4606.3 5115.4 5351.3 5388.5 5404.9 5421.7 1358.2 1361.5 1361.7 1363.4 1365.7 825.9 866.7 873.7 873.7 881.5 4556.7 4568.1 4580.2 4592.6 4626.8 4816.7 4839.1 4853.8 4856.0 4856.3 4422.0 4515.6 4549.5 4583.8 4601.2 2493.2 2552.4 2572.8 2596.4 2798.3 5564.8 5596.6 5685.9 5694.3 5706.6 5588.7 5602.7 5604.7 5605.5 5611.4 5464.5 5661.9 5688.8 5701.8 5712.4 5529.2 5537.7 5557.1 5569.0 5579.6 5501.2 5501.4 5522.3 5527.0 5541.9 5494.4 5731.7 5768.0 5790.3 5803.7 3949.9 3968.1 3974.6 3984.8 3989.3 5303.7 5607.5 5621.5 5624.4 5627.0 5428.4 5435.9 5449.7 5465.4 5467.2 5394.2 5405.5 5453.6 5466.3 5476.8 5148.7 5275.8 5353.5 5358.2 5384.9 5429.6 5443.5 5443.7 5449.6 5463.8 5324.5 5332.3 5353.4 5354.5 5360.9 09:59:31 INFO - PROCESS | 15653 | 09:59:31 INFO - PROCESS | 15653 | [#5] yui.html Cycles:180 Average:20384.97 Median:4568.46 stddev:29268.64 (640.7%) stddev-sans-first:29313.43 09:59:31 INFO - PROCESS | 15653 | Values: 699.8 708.8 719.1 776.9 778.2 15791.4 16588.0 16615.5 16637.8 16673.1 14506.6 15495.5 15621.7 15626.8 15707.6 778.0 797.7 798.9 799.5 800.5 651.9 668.2 776.7 793.5 803.3 843.7 846.5 846.8 846.8 847.3 834.0 838.2 838.3 838.6 838.8 497.0 500.2 507.7 588.7 599.8 14789.1 14884.9 14885.8 14917.7 14922.4 13645.9 14377.9 14448.6 14541.7 14832.9 13220.5 13379.4 13400.0 13434.5 14205.6 4304.1 4376.6 4381.9 4507.4 4590.6 73979.6 75892.6 76121.9 76324.2 78703.0 11441.1 11492.4 11733.2 12066.7 12223.9 22041.6 22055.3 22093.0 22130.7 22254.7 8182.7 8184.1 8335.7 8352.8 8689.3 4509.8 4574.2 4600.8 4617.9 4620.0 3424.3 3525.0 3529.6 3536.1 3558.3 616.3 621.7 628.1 639.3 641.0 638.0 645.4 646.8 664.3 672.8 9333.5 9454.0 9467.0 9739.0 9786.9 536.5 599.3 627.7 650.9 662.7 4298.5 4543.7 4562.7 4609.3 4645.7 66963.7 69793.7 93586.0 115029.0 118473.0 100941.5 101139.0 102068.5 106257.3 107977.0 90933.5 91108.0 91791.5 92348.5 92657.0 8406.8 8484.5 8661.5 8678.8 8958.7 44188.3 51712.5 52186.2 52481.7 52931.9 72758.6 72888.0 78085.6 79391.0 81265.0 11533.5 11910.0 12247.4 12325.8 12326.7 12060.8 12068.2 12446.3 13066.0 13778.9 12218.2 12266.0 12561.2 12605.9 12981.4 12069.2 12143.7 12702.8 12756.2 12823.2 11431.8 11700.3 12125.3 12181.9 13185.4 10030.7 10063.6 10191.8 10287.1 10293.2 10441.7 10726.3 10903.2 12085.8 12108.9 09:59:31 INFO - PROCESS | 15653 | -------- Summary: end -------- 09:59:31 INFO - PROCESS | 15653 | 09:59:32 INFO - TEST-INFO | 15653: exit 0 09:59:32 INFO - TEST-OK | dromaeo_css | took 1118067ms 09:59:32 INFO - TEST-START | kraken 09:59:32 INFO - operating with platform_type : linux_ 09:59:32 INFO - Initialising browser for kraken test... 09:59:32 INFO - TEST-INFO | started process 15962 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjk2Q0v/profile http://localhost:39340/getInfo.html) 09:59:36 INFO - PROCESS | 15962 | __metrics Screen width/height:1600/1200 09:59:36 INFO - PROCESS | 15962 | colorDepth:24 09:59:36 INFO - PROCESS | 15962 | Browser inner width/height: 1024/697 09:59:36 INFO - PROCESS | 15962 | __metrics 09:59:36 INFO - PROCESS | 15962 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:59:36 INFO - PROCESS | 15962 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:37 INFO - PROCESS | 15962 | console.error: PushService: 09:59:37 INFO - PROCESS | 15962 | stateChangeProcessEnqueue: Error transitioning state 09:59:37 INFO - PROCESS | 15962 | UnknownError 09:59:37 INFO - TEST-INFO | 15962: exit 0 09:59:37 INFO - Browser initialized. 09:59:37 INFO - Running cycle 1/1 for kraken test... 09:59:37 INFO - TEST-INFO | started process 16045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjk2Q0v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:50 INFO - PROCESS | 16045 | RSS: Main: 172056576 09:59:50 INFO - PROCESS | 16045 | 09:59:52 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-beat-detection) 09:59:53 INFO - PROCESS | 16045 | RSS: Main: 233091072 09:59:53 INFO - PROCESS | 16045 | 09:59:56 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-dft) 09:59:56 INFO - PROCESS | 16045 | RSS: Main: 216043520 09:59:56 INFO - PROCESS | 16045 | 09:59:59 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-fft) 10:00:00 INFO - PROCESS | 16045 | RSS: Main: 297680896 10:00:00 INFO - PROCESS | 16045 | 10:00:02 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39340/tests/kraken/driver.html?testName=audio-oscillator) 10:00:03 INFO - PROCESS | 16045 | RSS: Main: 206721024 10:00:03 INFO - PROCESS | 16045 | 10:00:05 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:00:06 INFO - PROCESS | 16045 | RSS: Main: 211795968 10:00:06 INFO - PROCESS | 16045 | 10:00:08 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39340/tests/kraken/driver.html?testName=imaging-darkroom) 10:00:09 INFO - PROCESS | 16045 | RSS: Main: 248082432 10:00:09 INFO - PROCESS | 16045 | 10:00:12 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39340/tests/kraken/driver.html?testName=imaging-desaturate) 10:00:13 INFO - PROCESS | 16045 | RSS: Main: 246722560 10:00:13 INFO - PROCESS | 16045 | 10:00:16 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39340/tests/kraken/driver.html?testName=json-parse-financial) 10:00:16 INFO - PROCESS | 16045 | RSS: Main: 246304768 10:00:16 INFO - PROCESS | 16045 | 10:00:18 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:00:18 INFO - PROCESS | 16045 | RSS: Main: 208646144 10:00:18 INFO - PROCESS | 16045 | 10:00:20 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:00:21 INFO - PROCESS | 16045 | RSS: Main: 217108480 10:00:21 INFO - PROCESS | 16045 | 10:00:23 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:00:23 INFO - PROCESS | 16045 | RSS: Main: 225726464 10:00:23 INFO - PROCESS | 16045 | 10:00:26 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:00:27 INFO - PROCESS | 16045 | RSS: Main: 229285888 10:00:27 INFO - PROCESS | 16045 | 10:00:30 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:00:30 INFO - PROCESS | 16045 | RSS: Main: 230686720 10:00:30 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | Cycle 1(1): loaded http://localhost:39340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39340/tests/kraken/driver.html?testName=ai-astar) 10:00:32 INFO - PROCESS | 16045 | RSS: Main: 282226688 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | __start_tp_report 10:00:32 INFO - PROCESS | 16045 | _x_x_mozilla_page_load 10:00:32 INFO - PROCESS | 16045 | _x_x_mozilla_page_load_details 10:00:32 INFO - PROCESS | 16045 | |i|pagename|runs| 10:00:32 INFO - PROCESS | 16045 | |0;ai-astar;103;110;110;118;111;110;111;113;110;109 10:00:32 INFO - PROCESS | 16045 | |1;audio-beat-detection;147;127;123;165;125;125;134;124;164;124 10:00:32 INFO - PROCESS | 16045 | |2;audio-dft;162;162;164;163;163;164;163;162;161;161 10:00:32 INFO - PROCESS | 16045 | |3;audio-fft;76;76;77;109;76;76;79;76;106;76 10:00:32 INFO - PROCESS | 16045 | |4;audio-oscillator;84;85;109;84;84;83;102;84;83;113 10:00:32 INFO - PROCESS | 16045 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;117;117;117 10:00:32 INFO - PROCESS | 16045 | |6;imaging-darkroom;146;146;145;146;146;147;147;147;145;146 10:00:32 INFO - PROCESS | 16045 | |7;imaging-desaturate;84;85;85;84;85;85;84;85;84;85 10:00:32 INFO - PROCESS | 16045 | |8;json-parse-financial;53;53;52;52;52;53;54;53;54;53 10:00:32 INFO - PROCESS | 16045 | |9;json-stringify-tinderbox;59;60;59;60;60;60;60;61;60;60 10:00:32 INFO - PROCESS | 16045 | |10;stanford-crypto-aes;84;86;81;81;80;80;81;86;81;79 10:00:32 INFO - PROCESS | 16045 | |11;stanford-crypto-ccm;134;140;133;135;135;135;131;149;197;130 10:00:32 INFO - PROCESS | 16045 | |12;stanford-crypto-pbkdf2;178;172;167;170;171;167;168;167;168;165 10:00:32 INFO - PROCESS | 16045 | |13;stanford-crypto-sha256-iterative;66;67;67;67;66;67;66;79;68;65 10:00:32 INFO - PROCESS | 16045 | __end_tp_report 10:00:32 INFO - PROCESS | 16045 | __start_cc_report 10:00:32 INFO - PROCESS | 16045 | _x_x_mozilla_cycle_collect,1698 10:00:32 INFO - PROCESS | 16045 | __end_cc_report 10:00:32 INFO - PROCESS | 16045 | __startTimestamp1476464432684__endTimestamp 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | ------- Summary: start ------- 10:00:32 INFO - PROCESS | 16045 | Number of tests: 14 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#0] ai-astar Cycles:10 Average:110.50 Median:110.50 stddev:3.69 (3.3%) stddev-sans-first:2.74 10:00:32 INFO - PROCESS | 16045 | Values: 103.0 110.0 110.0 118.0 111.0 110.0 111.0 113.0 110.0 109.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:130.50 stddev:16.77 (12.8%) stddev-sans-first:17.29 10:00:32 INFO - PROCESS | 16045 | Values: 147.0 127.0 123.0 165.0 125.0 125.0 134.0 124.0 164.0 124.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 10:00:32 INFO - PROCESS | 16045 | Values: 162.0 162.0 164.0 163.0 163.0 164.0 163.0 162.0 161.0 161.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:13.12 (17.3%) stddev-sans-first:13.69 10:00:32 INFO - PROCESS | 16045 | Values: 76.0 76.0 77.0 109.0 76.0 76.0 79.0 76.0 106.0 76.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:84.00 stddev:11.97 (14.2%) stddev-sans-first:12.41 10:00:32 INFO - PROCESS | 16045 | Values: 84.0 85.0 109.0 84.0 84.0 83.0 102.0 84.0 83.0 113.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:00:32 INFO - PROCESS | 16045 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 117.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 10:00:32 INFO - PROCESS | 16045 | Values: 146.0 146.0 145.0 146.0 146.0 147.0 147.0 147.0 145.0 146.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 10:00:32 INFO - PROCESS | 16045 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 10:00:32 INFO - PROCESS | 16045 | Values: 53.0 53.0 52.0 52.0 52.0 53.0 54.0 53.0 54.0 53.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 10:00:32 INFO - PROCESS | 16045 | Values: 59.0 60.0 59.0 60.0 60.0 60.0 60.0 61.0 60.0 60.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.00 stddev:2.51 (3.1%) stddev-sans-first:2.55 10:00:32 INFO - PROCESS | 16045 | Values: 84.0 86.0 81.0 81.0 80.0 80.0 81.0 86.0 81.0 79.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#11] stanford-crypto-ccm Cycles:10 Average:141.90 Median:135.00 stddev:20.10 (14.9%) stddev-sans-first:21.11 10:00:32 INFO - PROCESS | 16045 | Values: 134.0 140.0 133.0 135.0 135.0 135.0 131.0 149.0 197.0 130.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.00 stddev:3.71 (2.2%) stddev-sans-first:2.24 10:00:32 INFO - PROCESS | 16045 | Values: 178.0 172.0 167.0 170.0 171.0 167.0 168.0 167.0 168.0 165.0 10:00:32 INFO - PROCESS | 16045 | 10:00:32 INFO - PROCESS | 16045 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.00 stddev:4.02 (6.0%) stddev-sans-first:4.21 10:00:32 INFO - PROCESS | 16045 | Values: 66.0 67.0 67.0 67.0 66.0 67.0 66.0 79.0 68.0 65.0 10:00:32 INFO - PROCESS | 16045 | -------- Summary: end -------- 10:00:32 INFO - PROCESS | 16045 | 10:00:33 INFO - TEST-INFO | 16045: exit 0 10:00:33 INFO - TEST-OK | kraken | took 61632ms 10:00:33 INFO - SUITE-END | took 1179s 10:00:34 INFO - Completed test suite (00:19:40) 10:00:34 INFO - javascript benchmark 10:00:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2919.6204493415853, 2982.269344010717, 2992.1472380371597, 3041.163679988003, 3041.4221297953386, 5155.871103222421, 5178.844634660962, 5248.422673505911, 5270.7364631768405, 5365.624406291557, 5286.867828304295, 5299.867503312419, 5301.045811753883, 5309.787608495655, 5312.389075256347, 4784.330193772866, 4800.1119792838435, 4819.34938783265, 4853.660243782919, 4880.3655524781725, 4857.708537487744, 4878.829240976566, 4900.730459824708, 4901.0, 4905.4849240829735, 4781.689190202643, 4800.159972004903, 4826.0, 4838.733869637169, 4897.2898929655175, 4852.2479015752615, 4858.927116093244, 4878.731669758162, 4880.8047678092835, 4941.802327906879, 4708.128996135726, 4711.976440117812, 4776.188048031843, 4778.1638213312535, 4823.758812059418, 5289.814856480005, 5307.867303317409, 5311.150215965466, 5317.1492561190025, 5411.485908838654, 5613.719314034322, 5673.46102120302, 5677.318721753375, 5677.630953987978, 5682.488576028136, 5436.130219164915, 5563.026470367669, 5653.349864765563, 5701.287339082614, 5772.624779389326, 5289.841304760864, 5310.309659744247, 5338.706371149547, 5344.599155063386, 5348.171033489815, 5841.036229022164, 5850.210221620112, 5853.678047707332, 5855.941440585625, 5859.765609375577, 5299.761510732026, 5399.649022813504, 5586.636868603609, 5605.047141985872, 5615.8596035098635, 5540.279763630702, 5586.301712285965, 5593.720313984284, 5657.4908258256955, 5665.235193248858, 5538.390777014525, 5581.10702287632, 5585.888282234332, 5593.328800543961, 5593.720313984284, 5550.944490555124, 5559.833205003856, 5606.523445507096, 5617.129344951539, 5671.858203544944, 4322.502912165141, 4352.412424322739, 4368.453943257093, 4368.890777730582, 4370.453693288339, 3911.413288006822, 3929.901752456154, 3940.6847452203756, 3956.208758248362, 3956.7823769692945, 5351.973240133774, 5384.461553844662, 5390.407055223922, 5400.864978375494, 5402.108652072364, 5661.207430959669, 5686.175504551817, 5687.744051517691, 5693.28833895763, 5698.715064246771, 5362.839114826562, 5375.166849138312, 5382.192671099288, 5387.299651045339, 5400.9459905400445, 4953.306537084811, 4954.9009019819405, 4957.429895562056, 4957.702537847741, 4965.4289756678445, 5807.448292412214, 5820.156077368758, 5826.0678291474005, 5882.0, 5884.6469211847425, 5705.7147142643535, 5751.396103409082, 5754.539636829128, 5754.625949313281, 5758.3090029196765, 5721.771129154954, 5752.482276594959, 5753.568482363756, 5760.279965004374, 5888.911666325094, 5475.4524547544925, 5494.532964697885, 5500.202470641814, 5531.585131115263, 5549.112142057252, 5521.779128834802, 5561.5272701820795, 5594.552435805044, 5597.468240517144, 5601.607887448003, 5363.973180134074, 5449.23710680513, 5449.37900450954, 5449.918251226156, 5510.1459273812625, 5461.890762184814, 5490.149026900836, 5522.30971128609, 5527.917081243865, 5593.8321850344555, 5474.452554744494, 5479.917801232905, 5491.835244942658, 5516.503514683537, 5519.0, 5612.382637909745, 5634.718264086861, 5635.464630860061, 5642.971785141048, 5695.943040569541, 5302.0, 5319.255304257485, 5447.673139611636, 5500.7524661391135, 5503.394626590992], "value": 5217.457397539992, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.6073196777013, 594.5837913460578, 600.3366280260312, 609.4332270987985, 609.7134346856978, 31534.526982095285, 32147.03558893234, 34343.82828085862, 34393.140171495725, 34500.482492762625, 35122.8243858781, 42395.0, 44148.11703765923, 44208.3368749469, 47988.280175797394, 8883.244924181436, 9016.053314401992, 9016.323775716815, 9019.54902254888, 9022.0, 8188.672453101869, 8845.20393164615, 8934.106589341047, 8938.0, 8945.329100317469, 8207.507549547017, 10598.894011059869, 10902.291351062195, 10907.509162087725, 11182.440877956069, 10575.894241057567, 10648.893511064907, 10675.679729608124, 10676.839847402218, 10729.409882456463, 10505.842412363821, 10537.789244215073, 10564.26050176488, 10573.101286390665, 10578.57189279445, 40911.59088409108, 41549.37675934833, 41610.0, 41610.37584436236, 41630.1673966522, 3321.319129578455, 3391.220019395528, 3453.9654603453896, 3522.7005704515145, 3631.5460567429072, 31317.91919050801, 31672.36655266905, 31719.36561268785, 31727.52408713871, 31767.36465270705, 4257.254980378452, 4321.373400856858, 4362.062156636307, 4378.233809083429, 4537.614302784267, 314730.0, 316084.0, 316219.0, 317523.0, 317656.0, 56440.0, 56486.0, 56495.435045649014, 56917.0, 57031.57810531381, 60082.0, 60084.39915600788, 60112.69943650341, 60198.39801602015, 60259.69870150709, 16437.26032328548, 16625.251863666163, 16628.08545529983, 16660.75008874868, 16685.582860428345, 12822.487100515875, 12914.160579562298, 12922.806157907638, 12941.54704585335, 12944.0, 14832.703345933236, 14960.850391495946, 16743.66512669764, 16768.0, 16889.493315200565, 4944.008874630868, 5667.149927510906, 5911.4975227105315, 6008.939910600925, 6061.575689701678, 832.9167083291622, 886.601029536711, 935.8034812689275, 968.2060710217554, 988.456349008057, 28467.57298640522, 29730.0, 29957.251068723457, 30507.389852202832, 30540.0, 974.6734843827255, 1036.8496567997597, 1062.8246339354075, 1066.7333166708322, 1074.8172810622214, 15594.0, 15736.842631573538, 15968.361265549247, 15980.280887359864, 16184.19079046043, 464884.0, 466337.0, 467714.0, 467947.0, 468257.0, 54349.0, 55499.722501388045, 55649.0, 55683.443165568635, 57063.42936570581, 1275.2157423184674, 1305.9934700326437, 1311.5868501422021, 1311.9212847229196, 1320.3992183556459, 29316.0, 30599.847000765745, 30974.0, 31024.22439439032, 31036.53445198369, 50755.0, 51325.0, 51765.7411712939, 51804.0, 51842.48157518377, 469101.0, 474144.0, 478985.0, 671839.0, 672741.0, 26926.922923082857, 27267.181984540497, 27277.454450910474, 27305.863470682518, 27337.0, 45581.544184559054, 45625.54374456346, 45709.77145114253, 45823.77088114538, 45888.77055614701, 39314.41028384634, 39408.40887386634, 39462.605373947044, 39635.60364396319, 41414.79292603638, 39830.0, 40161.39757903692, 40519.392209117475, 41558.0, 41649.583504165785, 37340.439893401075, 37371.25257494889, 37755.81122094372, 37966.24067518579, 38250.80874595609, 33516.49725254172, 36303.818480908485, 36319.45520817137, 36555.81722091373, 37109.628903711695, 25556.0, 25999.090031848795, 26061.218163455127, 26100.8694956524, 26609.334766630214], "value": 19574.814121822223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.9082247793094, 367.68195510883083, 373.3261463059178, 374.6253746253748, 383.79275191396647, 13870.583882483528, 14106.717865642693, 15452.22738863058, 19052.61894762104, 19285.807141928577, 17713.7342939856, 18206.908965455186, 18221.0, 18503.537411564717, 18691.065446727676, 5243.764030618612, 5508.3114610673665, 5557.249771280886, 5566.582506312023, 5567.805126820562, 5342.118550439173, 5437.803683189692, 5443.346798384199, 5482.533984611313, 5494.752736126864, 5439.102548079562, 5443.129099344106, 5449.182622606601, 5453.072977593819, 5455.727213639302, 5271.5782737381105, 5441.319835020622, 5451.509364157225, 5459.617826752129, 5478.424765399655, 4863.440704319013, 4869.586085182764, 4870.780814863304, 4871.537203965618, 4876.341693871317, 21691.240806571852, 22204.777952220433, 22325.553488930294, 22329.77670223293, 22447.32658020262, 2346.389938615955, 2850.458412901542, 2870.368518925833, 2971.7325440710224, 3033.8634761435787, 13428.19430834153, 14128.85871141296, 14133.646658833508, 14692.0, 14791.038582492103, 1812.6012277298973, 1824.8540116790625, 1866.5333666583354, 1902.4387805597382, 1923.144200830631, 74215.0, 75545.62227188883, 77521.0, 77822.0, 78049.60975195144, 9606.51967401641, 9715.562799674031, 9744.63125697679, 9878.901210987799, 10135.087842094246, 13567.932160339134, 13575.796363054562, 13582.728345433035, 13593.077488340054, 13604.115732477358, 7389.66746496409, 7610.6194690265265, 7831.725889593837, 7866.921330786733, 7900.2889739923685, 7759.262870027338, 7779.876665367365, 7904.328132108835, 7906.169852165554, 8031.638576264082, 3994.6404823566018, 4012.3981402789814, 4032.2540330039037, 4119.588041195916, 4174.20690068886, 1731.5497970527754, 1810.4206653870635, 1833.5049536625036, 1835.3667984545311, 1878.2017642501883, 807.6955716517899, 809.0776514773163, 813.9064007639079, 818.7543736878913, 877.1535468273147, 16305.510834674978, 17021.614985860062, 17397.0, 17528.91235543814, 17899.284028638707, 856.4561503445357, 872.0407551693214, 874.580578553421, 882.8278485695228, 899.5187574647532, 9148.176664100263, 9508.096730810563, 9509.524523773784, 9648.469334186546, 9807.509624518745, 409777.0, 412904.0, 416135.0, 419980.0, 422750.0, 85788.57105714432, 86292.99999999875, 90976.54511727531, 94706.99810322479, 95441.0, 1010.8584798128268, 1030.1038096855634, 1048.7535429174138, 1055.1295181475314, 1062.1927335225284, 15459.304331305344, 15972.087998136409, 16371.59071023234, 17099.743503847203, 17108.657826843642, 30123.849380752956, 30409.087727368213, 42208.36687449629, 42399.788001059795, 43433.565664342954, 54793.72603136959, 54847.0, 56992.0, 60866.08700869579, 61410.69294653677, 7926.801829954297, 8349.916500834914, 8353.665853365797, 8539.74380768553, 8582.270507006975, 12443.75112497763, 13312.46750129984, 13525.323733813073, 13650.180989140683, 13697.520586779416, 11493.885061149282, 11569.0, 11588.246763960316, 11610.0, 12078.939605302268, 11309.604163854226, 11660.416979151178, 11765.058795296527, 11771.646850594154, 12272.38638068111, 11519.366434846164, 11562.248453850472, 11625.88374116248, 11681.591144309908, 12172.817407738714, 8232.464889782144, 8283.792905177419, 8543.871841922251, 8550.230479256898, 8737.956310218407, 10740.248182627141, 11542.59600913964, 11569.479373428048, 11673.0, 11936.791693536723], "value": 8811.407235922132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.2003697596567, 1395.8673925977032, 1425.0950646339572, 1519.4529969211083, 1726.9222884970168, 7746.61266936653, 8531.744047678572, 8769.91230087699, 8808.515531645766, 9036.63853445863, 8807.163319484654, 8944.95527522363, 8949.642014319435, 8956.596953137108, 8967.820643587125, 2300.02249044156, 2327.1273272522803, 2328.1851352026824, 2328.5459335429596, 2329.871857047862, 2251.2120757734824, 2273.6816845641624, 2296.7358753743283, 2300.804431623314, 2307.3193407944614, 2252.718410198725, 2278.737945136306, 2288.668143119247, 2290.9083636654514, 2294.7934685878267, 2227.6324406472913, 2260.3219034289727, 2264.049099378265, 2266.9886650566805, 2267.2178098556055, 2217.1265280837665, 2233.7207849018873, 2235.48583825721, 2237.127520267097, 2237.362351729749, 8675.609597568124, 8714.34642401816, 8802.07578204292, 8844.778880527974, 8874.778130546723, 5105.157648987913, 5293.947060529384, 5295.152775555931, 5298.576113910916, 5304.257403963448, 3295.3903527847187, 3454.913627159316, 3510.7893526388243, 3521.3485505181625, 3553.6091029986683, 1055.6727414501452, 1090.2041509697885, 1091.4215465803138, 1094.5074716377583, 1105.2263415609025, 12185.207961482476, 12205.877941220562, 12253.326067066308, 12285.570005049869, 12291.385430728516, 4182.64447521964, 4419.955800442019, 4451.265541185668, 4558.772061396917, 4566.634669226521, 9318.068193180628, 9324.766880827898, 9331.253499720005, 9339.0, 9349.953250233706, 5159.251908473326, 5161.0, 5163.845084647466, 5164.612654050961, 5172.094883395391, 4040.0, 4248.745075295492, 4309.547497512779, 4378.233809083397, 4841.225403935354, 3364.5794275715534, 3706.8517259309865, 3729.9813500932323, 3778.2065766188857, 3798.620137986179, 1107.0866535108569, 1136.8067428537167, 1141.2410746853416, 1147.7589706161632, 1153.0314535789976, 911.6809116809196, 919.9632014719336, 934.0123739232531, 937.2033771294482, 978.6672531339378, 5623.240862483594, 5728.05487094633, 5828.94171058284, 6087.634741915411, 6148.754049838046, 403.93133167361617, 405.25635458933186, 409.78076728949867, 413.53683874061244, 415.19037876141647, 3852.6725228355344, 4039.1921615676983, 4073.918521629551, 4110.479122724611, 4195.727277726938, 10784.245102842882, 11100.167487438475, 11112.222144449972, 11134.777304453866, 11229.3262404256, 11078.0, 11081.501332440059, 11091.44542772858, 11154.330740155616, 11167.106631469464, 7716.6527506262355, 7944.443888927835, 7972.0, 8068.717594884269, 8284.751457456287, 5490.450954904478, 5652.152177173457, 5673.943260567342, 6007.279126504847, 6009.759609615567, 9745.366551174435, 9997.600095996078, 9999.30004899679, 10019.499025048573, 10129.898701012895, 9046.411983221069, 9917.157041651251, 10016.949915250378, 10103.141232995278, 10377.688669339932, 7157.856842863218, 7473.0, 7635.618219089134, 7689.577073261024, 7835.570972998389, 8309.335253179852, 8321.875171872305, 8339.124391939002, 8413.663453461793, 8421.452605580618, 7266.636668166676, 7302.817429564303, 7311.122665280201, 7312.670929808065, 7351.742689005859, 7343.082114735658, 7437.575176805702, 7496.587687677012, 7529.472936894584, 7709.4603377763015, 6509.544331896722, 6591.242007169237, 6592.143021407186, 6600.801975940537, 6605.1083103780375, 5006.924896126488, 5038.899222015612, 5052.444231134498, 5068.087744206078, 5326.707031113326, 4905.558499734898, 4928.112939670894, 4993.725345105909, 5096.159133743039, 5117.181250999822], "value": 4418.573466206367, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.24091890732626, 313.2747689099734, 319.173341046689, 322.91765599772054, 324.66072953763313, 5111.207762796763, 5134.768935397911, 5147.433782283951, 5173.9482605173935, 5179.643262315647, 5071.79712811488, 5088.491150884919, 5123.462961111671, 5132.692038477694, 5134.512221338976, 4043.97978010111, 4045.4336392905016, 4046.8871060458464, 4055.6755459563165, 4067.7424029663525, 3848.7883166425836, 3990.5610382857863, 4036.9394459083137, 4051.858184963527, 4060.695447841409, 3996.1208534122593, 3998.260321840469, 4003.5596084430836, 4006.5392479864895, 4024.3762216856435, 3774.3770178823097, 4002.2795896738576, 4016.7389119707127, 4020.1758639478835, 4024.8591299304385, 3436.7937923724658, 3441.397755392821, 3510.508528805969, 3516.1033936346325, 3521.418965870628, 4949.208126699711, 4959.677620954626, 4963.354763880709, 4967.875803104916, 4971.527704868032, 4273.777635629486, 4513.413256276696, 4524.389207456984, 4530.207213737583, 4532.592066713979, 4900.0, 5269.973650131725, 5288.206768984644, 5353.170258609922, 5367.141257398836, 3883.0584707646176, 3886.689064874803, 3886.9222615547815, 3893.162969961472, 3902.551206611248, 5431.72354496693, 5460.399356070829, 5522.144067669517, 5541.944580554183, 5559.722013899289, 3957.56466788653, 3980.601939805996, 3985.70107241958, 3985.8405663773124, 4006.838016975103, 4018.4173294872667, 4019.8392064317686, 4024.537178224483, 4029.5567487576345, 4034.7579145250793, 4558.931616025762, 4561.3807098479565, 4562.133194692998, 4575.565321294472, 4606.286025666027, 5115.411727651368, 5351.25082488452, 5388.46115388458, 5404.945950540444, 5421.728913554307, 1358.2122369025942, 1361.5098564516766, 1361.7072329449215, 1363.4137320952086, 1365.706373129782, 825.8761185822175, 866.7009881590841, 873.6898401067657, 873.7422460374205, 881.5195718333396, 4556.749378784199, 4568.063546972862, 4580.24425969718, 4592.632589392841, 4626.768661566975, 4816.735079570587, 4839.080574690868, 4853.830115945925, 4855.951440485621, 4856.344393506902, 4421.977890110593, 4515.593596576324, 4549.476810166807, 4583.770811459413, 4601.217792975202, 2493.164789795439, 2552.3619095226195, 2572.816504407956, 2596.3638908467547, 2798.285662906977, 5564.772431989436, 5596.636218645775, 5685.914711279334, 5694.288213973254, 5706.629069110494, 5588.692621905753, 5602.6918519481005, 5604.719764011783, 5605.523530499953, 5611.354694210137, 5464.535514481234, 5661.915071273934, 5688.800891968761, 5701.771929122789, 5712.400197979318, 5529.180118139698, 5537.723113844211, 5557.110862262019, 5568.972155139199, 5579.581531385081, 5501.174823776466, 5501.367342755634, 5522.30971128609, 5526.972365138148, 5541.863917896902, 5494.423085576117, 5731.713414329351, 5767.971160144172, 5790.334111577223, 5803.680797556175, 3949.92100158001, 3968.1270120573427, 3974.5627980922654, 3984.7609143451486, 3989.2819292526465, 5303.734813259244, 5607.495325420732, 5621.4659607337235, 5624.409437009219, 5626.971865140812, 5428.430014848384, 5435.912817436608, 5449.7275136243825, 5465.426130256425, 5467.17992301158, 5394.163904594794, 5405.5135037846785, 5453.64551304164, 5466.316710411199, 5476.780928762805, 5148.734003679109, 5275.788968441219, 5353.491418315254, 5358.223057656696, 5384.946150538444, 5429.647072940246, 5443.537299329601, 5443.673379597237, 5449.5640348772795, 5463.836084917459, 5324.547413469899, 5332.253484512249, 5353.357597088374, 5354.54486368663, 5360.865978350573], "value": 4046.196041657152, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [699.821545505896, 708.8086216721485, 719.1334441997394, 776.9106552746432, 778.1792980545516, 15791.447299344525, 16588.0, 16615.501534953957, 16637.83362166378, 16673.082980436073, 14506.637334066654, 15495.535133946, 15621.687566248696, 15626.76559851603, 15707.60730981726, 778.0235804065903, 797.6769408389582, 798.872180451128, 799.4683535448919, 800.4836880212259, 651.8924377477734, 668.1781408867097, 776.7203806629609, 793.5040599625235, 803.3252068262658, 843.6667516331046, 846.475185385059, 846.8052347959973, 846.826400587878, 847.3306088190322, 833.9666413343459, 838.2330167896367, 838.266516797802, 838.5765188579759, 838.828040251747, 496.97018178909383, 500.2371383639942, 507.6598678885119, 588.6997631208072, 599.7780821096222, 14789.112653240732, 14884.925575372163, 14885.776713349309, 14917.731992780627, 14922.403103875831, 13645.931770341183, 14377.856221437862, 14448.638784030378, 14541.70916581673, 14832.851671483255, 13220.537281195113, 13379.397927093305, 13400.0, 13434.462621495128, 14205.573832785032, 4304.096139810644, 4376.606105450493, 4381.868543943655, 4507.414036175309, 4590.6327493800745, 73979.63010184915, 75892.62053689752, 76121.85817212747, 76324.23675763227, 78703.0, 11441.141914356456, 11492.367919764327, 11733.237339572901, 12066.69833254158, 12223.877761222451, 22041.559168816853, 22055.33833984983, 22093.0, 22130.668039979413, 22254.666180007313, 8182.732423255668, 8184.099749027602, 8335.666573337, 8352.791180220544, 8689.348298877609, 4509.8146318209865, 4574.222382194968, 4600.838970636079, 4617.884552886205, 4620.0, 3424.3493736190544, 3524.9823750881083, 3529.576450825917, 3536.0629433200224, 3558.252766918976, 616.2604874151036, 621.6643012773143, 628.0861346740481, 639.268038096377, 641.0320416171614, 637.9872402551923, 645.3933302695451, 646.7606985415426, 664.3190729502298, 672.7847088931593, 9333.486658233727, 9453.952730236442, 9466.958634550194, 9738.951305243429, 9786.895817399294, 536.4742552298769, 599.3467120838308, 627.6767464755654, 650.8633187030777, 662.7382184037278, 4298.505671847777, 4543.727376357429, 4562.703424277412, 4609.285560738091, 4645.651576131736, 66963.66518167379, 69793.65103174452, 93586.0, 115029.0, 118473.0, 100941.49529252453, 101139.0, 102068.48965755124, 106257.34356640991, 107977.0, 90933.54533227292, 91108.0, 91791.54104229437, 92348.53825730829, 92657.0, 8406.831863362577, 8484.490930544187, 8661.476231564682, 8678.78303042429, 8958.68644597436, 44188.33717494176, 51712.482875172274, 52186.21720674269, 52481.7375913118, 52931.94136117333, 72758.63620681863, 72888.0, 78085.60957195178, 79391.0, 81265.0, 11533.480993355486, 11910.022494376406, 12247.448864801283, 12325.815112773495, 12326.691832704255, 12060.811314843286, 12068.155229133876, 12446.25322480654, 13066.0, 13778.931105344409, 12218.20581662189, 12266.0, 12561.183523070971, 12605.93697031509, 12981.415836287579, 12069.215500992408, 12143.696407589881, 12702.809457858324, 12756.234625922474, 12823.230606163661, 11431.828522572001, 11700.2979821211, 12125.333106679218, 12181.939090304491, 13185.40665670028, 10030.699079027641, 10063.597456101967, 10191.776986761635, 10287.125594324267, 10293.228007899288, 10441.68674939753, 10726.302790318605, 10903.182261330274, 12085.75828483443, 12108.939455302667], "value": 7354.486280790011, "unit": "score"}], "name": "dromaeo_css", "value": 7006.83315940243, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 118.0, 111.0, 110.0, 111.0, 113.0, 110.0, 109.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 123.0, 165.0, 125.0, 125.0, 134.0, 124.0, 164.0, 124.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 163.0, 164.0, 163.0, 162.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 109.0, 76.0, 76.0, 79.0, 76.0, 106.0, 76.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 109.0, 84.0, 84.0, 83.0, 102.0, 84.0, 83.0, 113.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 52.0, 52.0, 53.0, 54.0, 53.0, 54.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 81.0, 81.0, 80.0, 80.0, 81.0, 86.0, 81.0, 79.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 140.0, 133.0, 135.0, 135.0, 135.0, 131.0, 149.0, 197.0, 130.0], "value": 141.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 172.0, 167.0, 170.0, 171.0, 167.0, 168.0, 167.0, 168.0, 165.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 79.0, 68.0, 65.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1504.2000000000003, "alertThreshold": 2.0}]} 10:00:34 INFO - Return code: 0 10:00:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:00:34 INFO - # TBPL SUCCESS # 10:00:34 INFO - Running post-action listener: _resource_record_post_action 10:00:34 INFO - [mozharness: 2016-10-14 17:00:34.468082Z] Finished run-tests step (success) 10:00:34 INFO - Running post-run listener: _resource_record_post_run 10:00:34 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400658432; Read time: 20; Write time: 309640 10:00:34 INFO - TinderboxPrint: CPU usage
13.1% 10:00:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 10:00:34 INFO - TinderboxPrint: I/O write bytes / time
400,658,432 / 309,640 10:00:34 INFO - TinderboxPrint: CPU idle
8,299.4 (86.9%) 10:00:34 INFO - TinderboxPrint: CPU user
1,199.9 (12.6%) 10:00:34 INFO - TinderboxPrint: Swap in / out
0 / 0 10:00:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112099328; Read time: 0; Write time: 93904 10:00:34 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288559104; Read time: 0; Write time: 215736 10:00:35 INFO - Running post-run listener: _upload_blobber_files 10:00:35 INFO - Blob upload gear active. 10:00:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:00:35 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 10:00:35 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'] 10:00:35 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 10:00:35 INFO - (blobuploader) - INFO - Open directory for files ... 10:00:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:00:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:00:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:39 INFO - (blobuploader) - INFO - Done attempting. 10:00:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:00:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:00:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:40 INFO - (blobuploader) - INFO - Done attempting. 10:00:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:00:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:00:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:00:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:00:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:00:40 INFO - (blobuploader) - INFO - Done attempting. 10:00:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:00:40 INFO - Return code: 0 10:00:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:00:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:00:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3f8a5a48cf0cdf0b329b21d53a61838971b7fa491618364504f4ab14e1a6531993fd931f009af12dfa6223bb2e14764b16f7618ffacfdf8e6a26eb4a18e6f38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b870a5dcab69a866b65ae68225013d0c52f79867c9f2e6a87efee56affff7517482ebb5105ccf0b76a98309920d80eed65ae6019048128c5875f633036b26791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac5bcaa36c2e09b28bc96a50ef2f1726a25e57cb2ccb6998bddaf1e1711be8646f2b6510c000e9dbc2bd0006694427806312a505e5c901309ce8ca759b939695"} 10:00:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:00:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:00:40 INFO - Contents: 10:00:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3f8a5a48cf0cdf0b329b21d53a61838971b7fa491618364504f4ab14e1a6531993fd931f009af12dfa6223bb2e14764b16f7618ffacfdf8e6a26eb4a18e6f38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b870a5dcab69a866b65ae68225013d0c52f79867c9f2e6a87efee56affff7517482ebb5105ccf0b76a98309920d80eed65ae6019048128c5875f633036b26791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac5bcaa36c2e09b28bc96a50ef2f1726a25e57cb2ccb6998bddaf1e1711be8646f2b6510c000e9dbc2bd0006694427806312a505e5c901309ce8ca759b939695"} 10:00:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:00:40 INFO - Copying logs to upload dir... 10:00:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:00:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.179250 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-14 10:00:40.692772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:00:40.696061) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3f8a5a48cf0cdf0b329b21d53a61838971b7fa491618364504f4ab14e1a6531993fd931f009af12dfa6223bb2e14764b16f7618ffacfdf8e6a26eb4a18e6f38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b870a5dcab69a866b65ae68225013d0c52f79867c9f2e6a87efee56affff7517482ebb5105ccf0b76a98309920d80eed65ae6019048128c5875f633036b26791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac5bcaa36c2e09b28bc96a50ef2f1726a25e57cb2ccb6998bddaf1e1711be8646f2b6510c000e9dbc2bd0006694427806312a505e5c901309ce8ca759b939695"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011178 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1476451805/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a3f8a5a48cf0cdf0b329b21d53a61838971b7fa491618364504f4ab14e1a6531993fd931f009af12dfa6223bb2e14764b16f7618ffacfdf8e6a26eb4a18e6f38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b870a5dcab69a866b65ae68225013d0c52f79867c9f2e6a87efee56affff7517482ebb5105ccf0b76a98309920d80eed65ae6019048128c5875f633036b26791", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac5bcaa36c2e09b28bc96a50ef2f1726a25e57cb2ccb6998bddaf1e1711be8646f2b6510c000e9dbc2bd0006694427806312a505e5c901309ce8ca759b939695"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 10:00:40.721170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:00:40.721485) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1476463200.800600-1331134463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 10:00:40.803715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:00:40.804029) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 10:00:40.804310) ========= ========= Total master_lag: 0.16 =========