builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-047 starttime: 1478187097.45 results: success (0) buildid: 20161103071338 builduid: f279f4acdc5d4f7a8de7cfe20f7c9d1b revision: 28ed60ea7e1117144e10ed931df1dfc9437dacbf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.450619) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.451093) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.451405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.467316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.467866) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-03 08:31:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-11-03 08:31:37 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100569 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.583361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.583762) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:37.633389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 08:31:37.633734) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 28ed60ea7e1117144e10ed931df1dfc9437dacbf --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 28ed60ea7e1117144e10ed931df1dfc9437dacbf --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=03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-03 08:31:37,795 truncating revision to first 12 chars 2016-11-03 08:31:37,795 Setting DEBUG logging. 2016-11-03 08:31:37,795 attempt 1/10 2016-11-03 08:31:37,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/28ed60ea7e11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 08:31:38,734 unpacking tar archive at: mozilla-inbound-28ed60ea7e11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.270302 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-03 08:31:38.917170) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:38.922199) ========= script_repo_revision: 28ed60ea7e1117144e10ed931df1dfc9437dacbf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:38.922662) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:38.922935) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 08:31:38.935771) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-03 08:31:38.936117) ========= /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=03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:31:39 INFO - MultiFileLogger online at 20161103 08:31:39 in /builds/slave/test 08:31:39 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 08:31:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:31:39 INFO - {'append_to_log': False, 08:31:39 INFO - 'base_work_dir': '/builds/slave/test', 08:31:39 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 08:31:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:31:39 INFO - 'branch': 'Mozilla-Inbound', 08:31:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:31:39 INFO - 'config_files': ('talos/linux_config.py',), 08:31:39 INFO - 'default_actions': ('clobber', 08:31:39 INFO - 'read-buildbot-config', 08:31:39 INFO - 'download-and-extract', 08:31:39 INFO - 'populate-webroot', 08:31:39 INFO - 'create-virtualenv', 08:31:39 INFO - 'install', 08:31:39 INFO - 'run-tests'), 08:31:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:31:39 INFO - 'download_minidump_stackwalk': True, 08:31:39 INFO - 'download_symbols': 'ondemand', 08:31:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:31:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:31:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:31:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:31:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:31:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:31:39 INFO - 'installer_path': 'installer.exe', 08:31:39 INFO - 'log_level': 'info', 08:31:39 INFO - 'log_name': 'talos', 08:31:39 INFO - 'log_to_console': True, 08:31:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:31:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:31:39 INFO - 'opt_config_files': (), 08:31:39 INFO - 'pip_index': False, 08:31:39 INFO - 'sps_profile': False, 08:31:39 INFO - 'sps_profile_interval': 0, 08:31:39 INFO - 'suite': 'dromaeojs', 08:31:39 INFO - 'system_bits': '32', 08:31:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:31:39 INFO - 'title': 'talos-linux64-ix-047', 08:31:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:31:39 INFO - 'use_talos_json': True, 08:31:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:31:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:31:39 INFO - 'work_dir': 'build'} 08:31:39 INFO - [mozharness: 2016-11-03 15:31:39.202620Z] Running clobber step. 08:31:39 INFO - Running pre-action listener: _resource_record_pre_action 08:31:39 INFO - Running main action method: clobber 08:31:39 INFO - rmtree: /builds/slave/test/build 08:31:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:31:40 INFO - Running post-action listener: _resource_record_post_action 08:31:40 INFO - [mozharness: 2016-11-03 15:31:40.177253Z] Finished clobber step (success) 08:31:40 INFO - [mozharness: 2016-11-03 15:31:40.177364Z] Running read-buildbot-config step. 08:31:40 INFO - Running pre-action listener: _resource_record_pre_action 08:31:40 INFO - Running main action method: read_buildbot_config 08:31:40 INFO - Using buildbot properties: 08:31:40 INFO - { 08:31:40 INFO - "project": "", 08:31:40 INFO - "product": "firefox", 08:31:40 INFO - "script_repo_revision": "production", 08:31:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 08:31:40 INFO - "repository": "", 08:31:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 08:31:40 INFO - "buildid": "20161103071338", 08:31:40 INFO - "stage_platform": "linux64-pgo", 08:31:40 INFO - "basedir": "/builds/slave/test", 08:31:40 INFO - "buildnumber": 2764, 08:31:40 INFO - "platform": "ubuntu64_hw", 08:31:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:31:40 INFO - "slavebuilddir": "test", 08:31:40 INFO - "branch": "mozilla-inbound", 08:31:40 INFO - "revision": "28ed60ea7e1117144e10ed931df1dfc9437dacbf", 08:31:40 INFO - "slavename": "talos-linux64-ix-047", 08:31:40 INFO - "builduid": "f279f4acdc5d4f7a8de7cfe20f7c9d1b", 08:31:40 INFO - "repo_path": "integration/mozilla-inbound" 08:31:40 INFO - } 08:31:40 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:31:40 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 08:31:40 INFO - Running post-action listener: _resource_record_post_action 08:31:40 INFO - [mozharness: 2016-11-03 15:31:40.179745Z] Finished read-buildbot-config step (success) 08:31:40 INFO - [mozharness: 2016-11-03 15:31:40.179834Z] Running download-and-extract step. 08:31:40 INFO - Running pre-action listener: _resource_record_pre_action 08:31:40 INFO - Running main action method: download_and_extract 08:31:40 INFO - mkdir: /builds/slave/test/build/tests 08:31:40 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')]} 08:31:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:31:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/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 08:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/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 08:31:40 INFO - Downloaded 1361 bytes. 08:31:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:31:40 INFO - Using the following test package requirements: 08:31:40 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:40 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:31:40 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:31:40 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'jsshell-linux-x86_64.zip'], 08:31:40 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:31:40 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:31:40 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:31:40 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:31:40 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:31:40 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:31:40 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:31:40 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:31:40 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/1478091748/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:31:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:31:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:31:40 INFO - Http code: 200 08:31:40 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:31:40 INFO - x-amz-cf-id: WNxX-WjiwR-U2NgolwydlclOq-6xzvDjwWd4O7qY-OqHWFi4_M-8pQ== 08:31:40 INFO - x-amz-replication-status: COMPLETED 08:31:40 INFO - x-amz-version-id: bFP6XlUqszcY8LPjecb8MdSt1iVNiS0Q 08:31:40 INFO - Expected file size: 22019856 08:31:40 INFO - Obtained file size: 22019856 08:31:44 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 08:31:44 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/1478091748/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:31:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:31:44 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:31:44 INFO - Http code: 200 08:31:44 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 08:31:44 INFO - x-amz-cf-id: 2HgJFI_psGMe-x7yuqAfwLrW7zoV747EH0TrSoFHXLyEhNOxqrmwUw== 08:31:44 INFO - x-amz-replication-status: COMPLETED 08:31:44 INFO - x-amz-version-id: bFP6XlUqszcY8LPjecb8MdSt1iVNiS0Q 08:31:45 INFO - Expected file size: 22019856 08:31:45 INFO - Obtained file size: 22019856 08:31:49 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/1478091748/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:31:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:31:49 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:31:49 INFO - Http code: 200 08:31:49 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:31:49 INFO - x-amz-cf-id: 7A68eBSj4Y2mprzZcP6ocKJznz2O5XvcSGO2WXVU1l3JgNFb2tZ_og== 08:31:49 INFO - x-amz-replication-status: COMPLETED 08:31:49 INFO - x-amz-version-id: CwKlgv.7BpdwYrJIJVCodw3Eg2_X2UM. 08:31:49 INFO - Expected file size: 14409038 08:31:49 INFO - Obtained file size: 14409038 08:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:49 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:31:49 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/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 08:31:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/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 08:31:50 INFO - Downloaded 59617833 bytes. 08:31:50 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:31:50 INFO - mkdir: /builds/slave/test/properties 08:31:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:31:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:31:50 INFO - Contents: 08:31:50 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:31:51 INFO - Running post-action listener: _resource_record_post_action 08:31:51 INFO - Running post-action listener: set_extra_try_arguments 08:31:51 INFO - [mozharness: 2016-11-03 15:31:51.042824Z] Finished download-and-extract step (success) 08:31:51 INFO - [mozharness: 2016-11-03 15:31:51.043053Z] Running populate-webroot step. 08:31:51 INFO - Running pre-action listener: _resource_record_pre_action 08:31:51 INFO - Running main action method: populate_webroot 08:31:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:31:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:31:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:31:51 INFO - '--tppagecycles', 08:31:51 INFO - '7'], 08:31:51 INFO - 'tests': ['tsvgm']}}, 08:31:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:31:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:31:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:31:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:31:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:31:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['damp', 'tps']}, 08:31:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'tests': ['damp', 'tps']}, 08:31:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['dromaeo_dom']}, 08:31:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:31:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['basic_compositor_video']}, 08:31:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:31:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['a11yr', 08:31:51 INFO - 'ts_paint', 08:31:51 INFO - 'tpaint', 08:31:51 INFO - 'sessionrestore', 08:31:51 INFO - 'sessionrestore_no_auto_restore', 08:31:51 INFO - 'tabpaint']}, 08:31:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:31:51 INFO - 'ts_paint', 08:31:51 INFO - 'tpaint', 08:31:51 INFO - 'sessionrestore', 08:31:51 INFO - 'sessionrestore_no_auto_restore', 08:31:51 INFO - 'tabpaint']}, 08:31:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:31:51 INFO - 'ts_paint', 08:31:51 INFO - 'tpaint', 08:31:51 INFO - 'sessionrestore', 08:31:51 INFO - 'sessionrestore_no_auto_restore', 08:31:51 INFO - 'tabpaint']}, 08:31:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:31:51 INFO - 'ts_paint', 08:31:51 INFO - 'tpaint', 08:31:51 INFO - 'sessionrestore', 08:31:51 INFO - 'sessionrestore_no_auto_restore', 08:31:51 INFO - 'tabpaint']}, 08:31:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['a11yr', 08:31:51 INFO - 'ts_paint', 08:31:51 INFO - 'tpaint', 08:31:51 INFO - 'sessionrestore', 08:31:51 INFO - 'sessionrestore_no_auto_restore', 08:31:51 INFO - 'tabpaint']}, 08:31:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['a11yr', 08:31:51 INFO - 'ts_paint', 08:31:51 INFO - 'tpaint', 08:31:51 INFO - 'sessionrestore', 08:31:51 INFO - 'sessionrestore_no_auto_restore', 08:31:51 INFO - 'tabpaint']}, 08:31:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['tsvgx', 08:31:51 INFO - 'tsvgr_opacity', 08:31:51 INFO - 'tart', 08:31:51 INFO - 'tscrollx', 08:31:51 INFO - 'cart']}, 08:31:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:31:51 INFO - 'tsvgr_opacity', 08:31:51 INFO - 'tart', 08:31:51 INFO - 'tscrollx', 08:31:51 INFO - 'cart']}, 08:31:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'talos_options': ['--disable-e10s'], 08:31:51 INFO - 'tests': ['tp5o']}, 08:31:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'tests': ['tp5o']}, 08:31:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'talos_options': ['--disable-e10s', 08:31:51 INFO - '--xperf_path', 08:31:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:51 INFO - 'tests': ['tp5n']}, 08:31:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:31:51 INFO - 'talos_options': ['--xperf_path', 08:31:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:31:51 INFO - 'tests': ['tp5n']}}, 08:31:51 INFO - 'talos.zip': {'path': '', 08:31:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:31:51 INFO - Running post-action listener: _resource_record_post_action 08:31:51 INFO - [mozharness: 2016-11-03 15:31:51.065496Z] Finished populate-webroot step (success) 08:31:51 INFO - [mozharness: 2016-11-03 15:31:51.065586Z] Running create-virtualenv step. 08:31:51 INFO - Running pre-action listener: _resource_record_pre_action 08:31:51 INFO - Running main action method: create_virtualenv 08:31:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:31:51 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 08:31:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:31:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:31:51 INFO - Using real prefix '/usr' 08:31:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:31:51 INFO - Installing distribute.............................................................................................................................................................................................done. 08:31:53 INFO - Installing pip.................done. 08:31:53 INFO - Return code: 0 08:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:31:53 INFO - Reading from file tmpfile_stdout 08:31:53 INFO - Output received: 08:31:53 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) 08:31:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:31:53 INFO - Using env: {'DISPLAY': ':0', 08:31:53 INFO - 'HOME': '/home/cltbld', 08:31:53 INFO - 'LANG': 'en_US.UTF-8', 08:31:53 INFO - 'LANGUAGE': 'en_US:en', 08:31:53 INFO - 'LOGNAME': 'cltbld', 08:31:53 INFO - 'MAIL': '/var/mail/cltbld', 08:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:53 INFO - 'MOZ_NO_REMOTE': '1', 08:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:53 INFO - 'NO_EM_RESTART': '1', 08:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:53 INFO - 'PWD': '/builds/slave/test', 08:31:53 INFO - 'SHELL': '/bin/bash', 08:31:53 INFO - 'SHLVL': '1', 08:31:53 INFO - 'TERM': 'linux', 08:31:53 INFO - 'TMOUT': '86400', 08:31:53 INFO - 'USER': 'cltbld', 08:31:53 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:53 INFO - '_': '/tools/buildbot/bin/python'} 08:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:54 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 08:31:54 INFO - Cleaning up... 08:31:54 INFO - Return code: 0 08:31:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:31: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')]} 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31: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')]} 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:31:54 INFO - Using env: {'DISPLAY': ':0', 08:31:54 INFO - 'HOME': '/home/cltbld', 08:31:54 INFO - 'LANG': 'en_US.UTF-8', 08:31:54 INFO - 'LANGUAGE': 'en_US:en', 08:31:54 INFO - 'LOGNAME': 'cltbld', 08:31:54 INFO - 'MAIL': '/var/mail/cltbld', 08:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:54 INFO - 'MOZ_NO_REMOTE': '1', 08:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:54 INFO - 'NO_EM_RESTART': '1', 08:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:54 INFO - 'PWD': '/builds/slave/test', 08:31:54 INFO - 'SHELL': '/bin/bash', 08:31:54 INFO - 'SHLVL': '1', 08:31:54 INFO - 'TERM': 'linux', 08:31:54 INFO - 'TMOUT': '86400', 08:31:54 INFO - 'USER': 'cltbld', 08:31:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:54 INFO - '_': '/tools/buildbot/bin/python'} 08:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:54 INFO - Downloading/unpacking psutil>=3.1.1 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:56 INFO - Installing collected packages: psutil 08:31:56 INFO - Running setup.py install for psutil 08:31:56 INFO - building 'psutil._psutil_linux' extension 08:31:56 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 08:31:56 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 08:31:56 INFO - building 'psutil._psutil_posix' extension 08:31:56 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 08:31:56 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 08:31:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:31:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:31:56 INFO - Successfully installed psutil 08:31:56 INFO - Cleaning up... 08:31:56 INFO - Return code: 0 08:31:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:31:56 INFO - Using env: {'DISPLAY': ':0', 08:31:56 INFO - 'HOME': '/home/cltbld', 08:31:56 INFO - 'LANG': 'en_US.UTF-8', 08:31:56 INFO - 'LANGUAGE': 'en_US:en', 08:31:56 INFO - 'LOGNAME': 'cltbld', 08:31:56 INFO - 'MAIL': '/var/mail/cltbld', 08:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:56 INFO - 'MOZ_NO_REMOTE': '1', 08:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:56 INFO - 'NO_EM_RESTART': '1', 08:31:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:56 INFO - 'PWD': '/builds/slave/test', 08:31:56 INFO - 'SHELL': '/bin/bash', 08:31:56 INFO - 'SHLVL': '1', 08:31:56 INFO - 'TERM': 'linux', 08:31:56 INFO - 'TMOUT': '86400', 08:31:56 INFO - 'USER': 'cltbld', 08:31:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:56 INFO - '_': '/tools/buildbot/bin/python'} 08:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:31:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:31:59 INFO - Installing collected packages: mozsystemmonitor 08:31:59 INFO - Running setup.py install for mozsystemmonitor 08:31:59 INFO - Successfully installed mozsystemmonitor 08:31:59 INFO - Cleaning up... 08:31:59 INFO - Return code: 0 08:31:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:31:59 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 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:31:59 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 08:31:59 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 08:31:59 INFO - Using env: {'DISPLAY': ':0', 08:31:59 INFO - 'HOME': '/home/cltbld', 08:31:59 INFO - 'LANG': 'en_US.UTF-8', 08:31:59 INFO - 'LANGUAGE': 'en_US:en', 08:31:59 INFO - 'LOGNAME': 'cltbld', 08:31:59 INFO - 'MAIL': '/var/mail/cltbld', 08:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:31:59 INFO - 'MOZ_NO_REMOTE': '1', 08:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:31:59 INFO - 'NO_EM_RESTART': '1', 08:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:31:59 INFO - 'PWD': '/builds/slave/test', 08:31:59 INFO - 'SHELL': '/bin/bash', 08:31:59 INFO - 'SHLVL': '1', 08:31:59 INFO - 'TERM': 'linux', 08:31:59 INFO - 'TMOUT': '86400', 08:31:59 INFO - 'USER': 'cltbld', 08:31:59 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:31:59 INFO - '_': '/tools/buildbot/bin/python'} 08:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:31:59 INFO - Downloading/unpacking jsonschema==2.5.1 08:31:59 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 08:31:59 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 08:31:59 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 08:31:59 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 08:31:59 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 08:31:59 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 08:32:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:01 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:01 INFO - warning: no files found matching '*.txt' 08:32:01 INFO - no previously-included directories found matching 'build' 08:32:01 INFO - no previously-included directories found matching 'dist' 08:32:01 INFO - no previously-included directories found matching '.git*' 08:32:01 INFO - Installing collected packages: jsonschema, functools32 08:32:01 INFO - Running setup.py install for functools32 08:32:01 INFO - warning: no files found matching '*.txt' 08:32:01 INFO - no previously-included directories found matching 'build' 08:32:01 INFO - no previously-included directories found matching 'dist' 08:32:01 INFO - no previously-included directories found matching '.git*' 08:32:01 INFO - Successfully installed jsonschema functools32 08:32:01 INFO - Cleaning up... 08:32:01 INFO - Return code: 0 08:32:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:32:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:32:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:32:01 INFO - Using env: {'DISPLAY': ':0', 08:32:01 INFO - 'HOME': '/home/cltbld', 08:32:01 INFO - 'LANG': 'en_US.UTF-8', 08:32:01 INFO - 'LANGUAGE': 'en_US:en', 08:32:01 INFO - 'LOGNAME': 'cltbld', 08:32:01 INFO - 'MAIL': '/var/mail/cltbld', 08:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:01 INFO - 'MOZ_NO_REMOTE': '1', 08:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:01 INFO - 'NO_EM_RESTART': '1', 08:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:01 INFO - 'PWD': '/builds/slave/test', 08:32:01 INFO - 'SHELL': '/bin/bash', 08:32:01 INFO - 'SHLVL': '1', 08:32:01 INFO - 'TERM': 'linux', 08:32:01 INFO - 'TMOUT': '86400', 08:32:01 INFO - 'USER': 'cltbld', 08:32:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:01 INFO - '_': '/tools/buildbot/bin/python'} 08:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:32:02 INFO - Cleaning up... 08:32:02 INFO - Return code: 0 08:32:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:32:02 INFO - Using env: {'DISPLAY': ':0', 08:32:02 INFO - 'HOME': '/home/cltbld', 08:32:02 INFO - 'LANG': 'en_US.UTF-8', 08:32:02 INFO - 'LANGUAGE': 'en_US:en', 08:32:02 INFO - 'LOGNAME': 'cltbld', 08:32:02 INFO - 'MAIL': '/var/mail/cltbld', 08:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:02 INFO - 'MOZ_NO_REMOTE': '1', 08:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:02 INFO - 'NO_EM_RESTART': '1', 08:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:02 INFO - 'PWD': '/builds/slave/test', 08:32:02 INFO - 'SHELL': '/bin/bash', 08:32:02 INFO - 'SHLVL': '1', 08:32:02 INFO - 'TERM': 'linux', 08:32:02 INFO - 'TMOUT': '86400', 08:32:02 INFO - 'USER': 'cltbld', 08:32:02 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:02 INFO - '_': '/tools/buildbot/bin/python'} 08:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:04 INFO - Downloading docopt-0.6.1.tar.gz 08:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:04 INFO - Running setup.py install for blobuploader 08:32:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:05 INFO - Running setup.py install for requests 08:32:05 INFO - Running setup.py install for docopt 08:32:05 INFO - Successfully installed blobuploader requests docopt 08:32:05 INFO - Cleaning up... 08:32:05 INFO - Return code: 0 08:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:05 INFO - Using env: {'DISPLAY': ':0', 08:32:05 INFO - 'HOME': '/home/cltbld', 08:32:05 INFO - 'LANG': 'en_US.UTF-8', 08:32:05 INFO - 'LANGUAGE': 'en_US:en', 08:32:05 INFO - 'LOGNAME': 'cltbld', 08:32:05 INFO - 'MAIL': '/var/mail/cltbld', 08:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:05 INFO - 'MOZ_NO_REMOTE': '1', 08:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:05 INFO - 'NO_EM_RESTART': '1', 08:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:05 INFO - 'PWD': '/builds/slave/test', 08:32:05 INFO - 'SHELL': '/bin/bash', 08:32:05 INFO - 'SHLVL': '1', 08:32:05 INFO - 'TERM': 'linux', 08:32:05 INFO - 'TMOUT': '86400', 08:32:05 INFO - 'USER': 'cltbld', 08:32:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:05 INFO - '_': '/tools/buildbot/bin/python'} 08:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:05 INFO - Running setup.py (path:/tmp/pip-mW9g0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:05 INFO - Running setup.py (path:/tmp/pip-WPLqfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:05 INFO - Running setup.py (path:/tmp/pip-Xswwtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:06 INFO - Running setup.py (path:/tmp/pip-PwBuwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:06 INFO - Running setup.py (path:/tmp/pip-uh10B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:06 INFO - Running setup.py (path:/tmp/pip-c_UBfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:06 INFO - Running setup.py (path:/tmp/pip-Tugj_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:06 INFO - Running setup.py (path:/tmp/pip-8pGDzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:06 INFO - Running setup.py (path:/tmp/pip-gLr2kC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:06 INFO - Running setup.py (path:/tmp/pip-FPUs2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:06 INFO - Running setup.py (path:/tmp/pip-mPs11L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:06 INFO - Running setup.py (path:/tmp/pip-8jjBhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:06 INFO - Running setup.py (path:/tmp/pip-Fu4E6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:06 INFO - Running setup.py (path:/tmp/pip-iuw5IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:06 INFO - Running setup.py (path:/tmp/pip-t9IpBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:06 INFO - Running setup.py (path:/tmp/pip-S4opD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:06 INFO - Running setup.py (path:/tmp/pip-Wjr4FR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:07 INFO - Running setup.py install for manifestparser 08:32:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Running setup.py install for mozcrash 08:32:07 INFO - Running setup.py install for mozdebug 08:32:07 INFO - Running setup.py install for mozdevice 08:32:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Running setup.py install for mozfile 08:32:07 INFO - Running setup.py install for mozhttpd 08:32:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Running setup.py install for mozinfo 08:32:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Running setup.py install for mozInstall 08:32:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:07 INFO - Running setup.py install for mozleak 08:32:07 INFO - Running setup.py install for mozlog 08:32:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Running setup.py install for moznetwork 08:32:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Running setup.py install for mozprocess 08:32:08 INFO - Running setup.py install for mozprofile 08:32:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Running setup.py install for mozrunner 08:32:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Running setup.py install for mozscreenshot 08:32:08 INFO - Running setup.py install for moztest 08:32:08 INFO - Running setup.py install for mozversion 08:32:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:08 INFO - Cleaning up... 08:32:08 INFO - Return code: 0 08:32:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:08 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')]} 08:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:08 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')]} 08:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:08 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 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:32:08 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 08:32:08 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 08:32:08 INFO - Using env: {'DISPLAY': ':0', 08:32:08 INFO - 'HOME': '/home/cltbld', 08:32:08 INFO - 'LANG': 'en_US.UTF-8', 08:32:08 INFO - 'LANGUAGE': 'en_US:en', 08:32:08 INFO - 'LOGNAME': 'cltbld', 08:32:08 INFO - 'MAIL': '/var/mail/cltbld', 08:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:08 INFO - 'MOZ_NO_REMOTE': '1', 08:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:08 INFO - 'NO_EM_RESTART': '1', 08:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:08 INFO - 'PWD': '/builds/slave/test', 08:32:08 INFO - 'SHELL': '/bin/bash', 08:32:08 INFO - 'SHLVL': '1', 08:32:08 INFO - 'TERM': 'linux', 08:32:08 INFO - 'TMOUT': '86400', 08:32:08 INFO - 'USER': 'cltbld', 08:32:08 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:08 INFO - '_': '/tools/buildbot/bin/python'} 08:32:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:09 INFO - Running setup.py (path:/tmp/pip-NUsTg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:09 INFO - Running setup.py (path:/tmp/pip-7dSXhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:09 INFO - Running setup.py (path:/tmp/pip-KMku7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:09 INFO - Running setup.py (path:/tmp/pip-ypVGoo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:09 INFO - Running setup.py (path:/tmp/pip-16g0ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:09 INFO - Running setup.py (path:/tmp/pip-iu6huy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:09 INFO - Running setup.py (path:/tmp/pip-AlhGE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:09 INFO - Running setup.py (path:/tmp/pip-wDCyCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:09 INFO - Running setup.py (path:/tmp/pip-lEbbdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:09 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)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:09 INFO - Running setup.py (path:/tmp/pip-7s_icx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:09 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)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:09 INFO - Running setup.py (path:/tmp/pip-fLdcsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:09 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)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:09 INFO - Running setup.py (path:/tmp/pip-FL_7_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:09 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)) 08:32:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:09 INFO - Running setup.py (path:/tmp/pip-RTjXfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:10 INFO - Running setup.py (path:/tmp/pip-4qOwms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:10 INFO - Running setup.py (path:/tmp/pip-seV3yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:10 INFO - Running setup.py (path:/tmp/pip-R9B4HS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:32:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:10 INFO - Running setup.py (path:/tmp/pip-W5QIoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:12 INFO - Downloading blessings-1.6.tar.gz 08:32:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:12 INFO - Installing collected packages: blessings 08:32:12 INFO - Running setup.py install for blessings 08:32:12 INFO - Successfully installed blessings 08:32:12 INFO - Cleaning up... 08:32:12 INFO - Return code: 0 08:32:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:12 INFO - Reading from file tmpfile_stdout 08:32:12 INFO - Current package versions: 08:32:12 INFO - argparse == 1.2.1 08:32:12 INFO - blessings == 1.6 08:32:12 INFO - blobuploader == 1.2.4 08:32:12 INFO - docopt == 0.6.1 08:32:12 INFO - functools32 == 3.2.3-2 08:32:12 INFO - jsonschema == 2.5.1 08:32:12 INFO - manifestparser == 1.1 08:32:12 INFO - mozInstall == 1.12 08:32:12 INFO - mozcrash == 0.17 08:32:12 INFO - mozdebug == 0.1 08:32:12 INFO - mozdevice == 0.48 08:32:12 INFO - mozfile == 1.2 08:32:12 INFO - mozhttpd == 0.7 08:32:12 INFO - mozinfo == 0.9 08:32:12 INFO - mozleak == 0.1 08:32:12 INFO - mozlog == 3.4 08:32:12 INFO - moznetwork == 0.27 08:32:12 INFO - mozprocess == 0.23 08:32:12 INFO - mozprofile == 0.28 08:32:12 INFO - mozrunner == 6.12 08:32:12 INFO - mozscreenshot == 0.1 08:32:12 INFO - mozsystemmonitor == 0.3 08:32:12 INFO - moztest == 0.7 08:32:12 INFO - mozversion == 1.4 08:32:12 INFO - psutil == 3.1.1 08:32:12 INFO - requests == 1.2.3 08:32:12 INFO - wsgiref == 0.1.2 08:32:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:12 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')]} 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:12 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')]} 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:12 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 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:32:12 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 08:32:12 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 08:32:12 INFO - Using env: {'DISPLAY': ':0', 08:32:12 INFO - 'HOME': '/home/cltbld', 08:32:12 INFO - 'LANG': 'en_US.UTF-8', 08:32:12 INFO - 'LANGUAGE': 'en_US:en', 08:32:12 INFO - 'LOGNAME': 'cltbld', 08:32:12 INFO - 'MAIL': '/var/mail/cltbld', 08:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:12 INFO - 'MOZ_NO_REMOTE': '1', 08:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:12 INFO - 'NO_EM_RESTART': '1', 08:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:12 INFO - 'PWD': '/builds/slave/test', 08:32:12 INFO - 'SHELL': '/bin/bash', 08:32:12 INFO - 'SHLVL': '1', 08:32:12 INFO - 'TERM': 'linux', 08:32:12 INFO - 'TMOUT': '86400', 08:32:12 INFO - 'USER': 'cltbld', 08:32:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:12 INFO - '_': '/tools/buildbot/bin/python'} 08:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 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)) 08:32:12 INFO - Cleaning up... 08:32:12 INFO - Return code: 0 08:32:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:12 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')]} 08:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:12 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')]} 08:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:12 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 0x7f1318663f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2482ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, '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': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', '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 08:32:12 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 08:32:12 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 08:32:12 INFO - Using env: {'DISPLAY': ':0', 08:32:12 INFO - 'HOME': '/home/cltbld', 08:32:12 INFO - 'LANG': 'en_US.UTF-8', 08:32:12 INFO - 'LANGUAGE': 'en_US:en', 08:32:12 INFO - 'LOGNAME': 'cltbld', 08:32:12 INFO - 'MAIL': '/var/mail/cltbld', 08:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:12 INFO - 'MOZ_NO_REMOTE': '1', 08:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:12 INFO - 'NO_EM_RESTART': '1', 08:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:12 INFO - 'PWD': '/builds/slave/test', 08:32:12 INFO - 'SHELL': '/bin/bash', 08:32:12 INFO - 'SHLVL': '1', 08:32:12 INFO - 'TERM': 'linux', 08:32:12 INFO - 'TMOUT': '86400', 08:32:12 INFO - 'USER': 'cltbld', 08:32:12 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:12 INFO - '_': '/tools/buildbot/bin/python'} 08:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:32:13 INFO - Cleaning up... 08:32:13 INFO - Return code: 0 08:32:13 INFO - Running post-action listener: _resource_record_post_action 08:32:13 INFO - Running post-action listener: _start_resource_monitoring 08:32:13 INFO - Starting resource monitoring. 08:32:13 INFO - [mozharness: 2016-11-03 15:32:13.178416Z] Finished create-virtualenv step (success) 08:32:13 INFO - [mozharness: 2016-11-03 15:32:13.178928Z] Running install step. 08:32:13 INFO - Running pre-action listener: _resource_record_pre_action 08:32:13 INFO - Running main action method: install 08:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:13 INFO - Reading from file tmpfile_stdout 08:32:13 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:13 INFO - Reading from file tmpfile_stdout 08:32:13 INFO - Output received: 08:32:13 INFO - Usage: mozinstall [options] installer 08:32:13 INFO - Options: 08:32:13 INFO - -h, --help show this help message and exit 08:32:13 INFO - -d DEST, --destination=DEST 08:32:13 INFO - Directory to install application into. [default: 08:32:13 INFO - "/builds/slave/test"] 08:32:13 INFO - --app=APP Application being installed. [default: firefox] 08:32:13 INFO - mkdir: /builds/slave/test/build/application 08:32:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:32:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:32:30 INFO - Reading from file tmpfile_stdout 08:32:30 INFO - Output received: 08:32:30 INFO - /builds/slave/test/build/application/firefox/firefox 08:32:30 INFO - Running post-action listener: _resource_record_post_action 08:32:30 INFO - [mozharness: 2016-11-03 15:32:30.440123Z] Finished install step (success) 08:32:30 INFO - [mozharness: 2016-11-03 15:32:30.440397Z] Running run-tests step. 08:32:30 INFO - Running pre-action listener: _resource_record_pre_action 08:32:30 INFO - Running main action method: run_tests 08:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:32:30 INFO - Python 2.7.3 08:32:30 INFO - Return code: 0 08:32:30 INFO - grabbing minidump binary from tooltool 08:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x247ff60>, '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 0x2480d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24811d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:32:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:32:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:32:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:32:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:30 INFO - Return code: 0 08:32:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:32:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:32:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:32:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:32:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 08:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 08:32:30 INFO - Using env: {'DISPLAY': ':0', 08:32:30 INFO - 'HOME': '/home/cltbld', 08:32:30 INFO - 'LANG': 'en_US.UTF-8', 08:32:30 INFO - 'LANGUAGE': 'en_US:en', 08:32:30 INFO - 'LOGNAME': 'cltbld', 08:32:30 INFO - 'MAIL': '/var/mail/cltbld', 08:32:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:32:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:30 INFO - 'MOZ_NO_REMOTE': '1', 08:32:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:30 INFO - 'NO_EM_RESTART': '1', 08:32:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:30 INFO - 'PWD': '/builds/slave/test', 08:32:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:32:30 INFO - 'SHELL': '/bin/bash', 08:32:30 INFO - 'SHLVL': '1', 08:32:30 INFO - 'TERM': 'linux', 08:32:30 INFO - 'TMOUT': '86400', 08:32:30 INFO - 'USER': 'cltbld', 08:32:30 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017', 08:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:30 INFO - '_': '/tools/buildbot/bin/python'} 08:32:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 08:32:30 INFO - mozversion application_buildid: 20161102060228 08:32:30 INFO - mozversion application_changeset: 28ed60ea7e1117144e10ed931df1dfc9437dacbf 08:32:30 INFO - mozversion application_display_name: Nightly 08:32:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:30 INFO - mozversion application_name: Firefox 08:32:30 INFO - mozversion application_remotingname: firefox 08:32:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:32:30 INFO - mozversion application_vendor: Mozilla 08:32:30 INFO - mozversion application_version: 52.0a1 08:32:30 INFO - mozversion platform_buildid: 20161102060228 08:32:30 INFO - mozversion platform_changeset: 28ed60ea7e1117144e10ed931df1dfc9437dacbf 08:32:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 08:32:30 INFO - mozversion platform_version: 52.0a1 08:32:30 INFO - using testdate: 1478187150 08:32:30 INFO - actual date: 1478187150 08:32:30 INFO - starting webserver on 'localhost:33728' 08:32:30 INFO - SUITE-START | Running 2 tests 08:32:30 INFO - TEST-START | dromaeo_css 08:32:30 INFO - operating with platform_type : linux_ 08:32:30 INFO - Initialising browser for dromaeo_css test... 08:32:30 INFO - TEST-INFO | started process 15028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphKIqwx/profile http://localhost:33728/getInfo.html) 08:32:34 INFO - PROCESS | 15028 | __metrics Screen width/height:1600/1200 08:32:34 INFO - PROCESS | 15028 | colorDepth:24 08:32:34 INFO - PROCESS | 15028 | Browser inner width/height: 1024/697 08:32:34 INFO - PROCESS | 15028 | __metrics 08:32:35 INFO - PROCESS | 15028 | 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" 08:32:35 INFO - PROCESS | 15028 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:32:36 INFO - PROCESS | 15028 | console.error: PushService: 08:32:36 INFO - PROCESS | 15028 | stateChangeProcessEnqueue: Error transitioning state 08:32:36 INFO - PROCESS | 15028 | UnknownError 08:32:36 INFO - TEST-INFO | 15028: exit 0 08:32:36 INFO - Browser initialized. 08:32:36 INFO - Running cycle 1/1 for dromaeo_css test... 08:32:36 INFO - TEST-INFO | started process 15117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphKIqwx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:48 INFO - PROCESS | 15117 | RSS: Main: 172699648 08:32:48 INFO - PROCESS | 15117 | 08:33:39 INFO - PROCESS | 15117 | 1478187219949 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] 08:35:51 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33728/tests/dromaeo/cssquery-ext.html) 08:35:54 INFO - PROCESS | 15117 | RSS: Main: 433713152 08:35:54 INFO - PROCESS | 15117 | 08:38:56 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-ext.html (next: http://localhost:33728/tests/dromaeo/cssquery-jquery.html) 08:38:57 INFO - PROCESS | 15117 | RSS: Main: 288481280 08:38:57 INFO - PROCESS | 15117 | 08:41:59 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33728/tests/dromaeo/cssquery-mootools.html) 08:42:00 INFO - PROCESS | 15117 | RSS: Main: 222617600 08:42:00 INFO - PROCESS | 15117 | 08:45:02 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33728/tests/dromaeo/cssquery-prototype.html) 08:45:02 INFO - PROCESS | 15117 | RSS: Main: 219676672 08:45:02 INFO - PROCESS | 15117 | 08:48:05 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33728/tests/dromaeo/cssquery-yui.html) 08:48:06 INFO - PROCESS | 15117 | RSS: Main: 221741056 08:48:06 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | Cycle 1(1): loaded http://localhost:33728/tests/dromaeo/cssquery-yui.html (next: http://localhost:33728/tests/dromaeo/cssquery-dojo.html) 08:51:09 INFO - PROCESS | 15117 | RSS: Main: 312926208 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | __start_tp_report 08:51:09 INFO - PROCESS | 15117 | _x_x_mozilla_page_load 08:51:09 INFO - PROCESS | 15117 | _x_x_mozilla_page_load_details 08:51:09 INFO - PROCESS | 15117 | |i|pagename|runs| 08:51:09 INFO - PROCESS | 15117 | |0;dojo.html;2938.338873753405;2969.9851500742493;2992.985035074825;3001.939961200776;3014.773891958104;5212.582993360532;5279.155335146377;5300.469953004697;5343.225232341309;5435.157550579656;5192.402873669529;5208.062548741225;5230.1108811502045;5325.334333208349;5329.920051199235;4764.166270902596;4794;4842.564169224769;4844.07962487128;4863.805447782084;4815.735134567597;4861.124997500448;4879.585235255007;4882.121218180726;4944.752762361885;4761.500042495557;4900.632452566037;4906.043321552299;4954.331165292693;4978.6514943953935;4799.664023518355;4861.513848615145;4865.221564549655;4867.780949857265;4869.634777391674;4842.539958703917;4854.6359023073055;4860.343853579757;4862.3922009748785;4869.074875773592;5246.81636142737;5296.947030529684;5297.47025297471;5299.390570084451;5312.4687531246955;5673.063944449161;5684.2326285951285;5694.572907031989;5698.715064246812;5702.771889124471;5709.200711900337;5736.713164341766;5740.684262365568;5753.510951569122;5757.596968212227;5315.202719592054;5357.223202635635;5363.383210930754;5365.678059316453;5370.382406023279;5745.913811292834;5749.8275051748515;5770.653760774367;5834.649921004753;5845.035569131131;5580.051391263495;5594.216809646653;5603.663780173121;5604.075327570987;5606;5516.117421212587;5551.3893471718075;5554.250176226238;5634;5670.206171136044;5611.551075913917;5616.9157462638095;5624.0439125348785;5624.268845050117;5626;5598.216249725042;5609.5792815539;5632.070708333161;5644.379118296984;5654;4331.328644060176;4339.587739164775;4342.522322544518;4344.087741574304;4344.304911214191;3495.563054618173;3844.308024555551;3848.3073046851837;3903.316919539126;3916.74541154824;5360.624756267024;5365.409804921455;5419.051665958442;5427.674339539641;5430.5384042356845;5620.49415552594;5695.145728140812;5699.344575373802;5701.515371193412;5735.942640573624;5217.50433708797;5263.815766448156;5358;5361.490658387447;5420.430854760193;4713.316569097462;4726.834560790356;4739.3838800955655;4762.3570817939135;4834.347363106006;5862.355140934494;5873.823785286449;5874.060150375919;5875.941240587539;5883.382244864228;5631.831045068655;5640.4077571856005;5641.661500309994;5654.321481422256;5654.46282603152;5698.831739493311;5743.195952566561;5851.034579294369;5925.822225333247;5936.910946335895;5592.692401917933;5639.915401268902;5642.6614403135945;5643.266375371176;5703.7433315500075;5688.345840228261;5739.282589676291;5743.511801496919;5748.252727145445;5762.2221000164445;5453.61824672285;5497.038018346853;5497.202905578749;5574.9721251393485;5601.80393686219;5561.110222364402;5572.275604171432;5572.331320241597;5575.581831362745;5581.358143813513;5533.529649979797;5546.4453554644215;5556.694381808878;5559.833205003856;5565.220869078414;5524.558035357081;5560.777568897361;5564.054110801255;5566.053770859045;5568.470995255444;5435.266239057834;5447;5450.427705090909;5457.890842183055;5458.781648734165 08:51:09 INFO - PROCESS | 15117 | |1;ext.html;581.8429024163476;598.9071693887447;604.5435696049482;604.770187328815;609.3449541742622;31842.20394490136;42064.789676051616;43073.13853722928;43523.56476435235;47042.76478617611;38844.80577597115;39516.209675806465;39589.010274743145;39885.40171897424;39903;8047.95976020122;8809.823803523926;8956.552172391386;8957.910420895805;8971.730848074536;8171.67313307467;10466.267361284714;10711.83932241017;10716.946415267952;11133.665990020312;10821.242513024092;10884.510197041152;10885.455727213608;10889.83665245022;10890.945545272263;10620.15038796902;10647.680569582924;10687.625933092304;10714.357138571671;10715.946420267926;10545.367277963347;10603.204759643058;10604.681859544226;10611.469426528643;10613.150947924147;41438;41716;41721.79139104315;41732.37401438981;41769.1646167078;3338.115399419156;3390.4066788311948;3411.4371128763723;3415.1291420687567;3453.2748122894222;31298.21754456134;31538.526922096185;31830;32852.507212391836;32926;4018.57804930481;4028.979855100735;4109.691773117028;4261.190373828963;4265.3815196796295;328567;329971;331513;332479.33760331286;332622;57463.71268143632;57826.42173578295;57924.23492472976;57948;58585.41414585885;58560;58891;63689;63786.68106659437;63790.043149352794;15554.688906221812;15714.29285682147;15751.68496630061;15839.524814255361;15866.127362995147;10601.946990265;10816;11141.777164456827;11626.70933226676;11909.22590031645;18913.14890829916;19775.912324821984;20065.29771457992;20093.698594521094;20135.798642013393;7237.312455316842;7522.811929701801;7583.886241706379;7660.310572048543;7720.845583088307;966.8066386722684;1124.876263611002;1133.9716507087223;1154.0709728668335;1172.267332916927;31091;31898.681013189573;32835.34329313448;34710.47934280988;35206;1019.9698304712146;1091.5984833366624;1143.4397145398696;1155.1798223261578;1195.7190060335813;15633.218339083;16386.26261818221;16528.504144875675;16558.254878530493;16716.74924876128;499523;504291;505307;505580;505800;54757;54826.17760733592;55023;55179;55554;1221.3404761428906;1226.533917111492;1280.6862318731785;1328.7342531493546;1374.5738820965532;27989.440211195255;31847.721020150566;32363.35273294568;32396.514052288763;32589.511157333134;48297;48892.26661600007;49230.261546077556;49291.26063109128;49344;392703;397736;397793.3420319855;397896;398237;25446.491070178123;26188.214353568663;27181.59227611548;28078.719212808428;28339;42597.787011065986;43319.56680433281;43382;43809.12381752411;44323.33514997342;37433.62566374301;37566.812165938994;38069.80965095157;38179.236415270985;38300;37144.25711485809;37642.81178594199;38276.80861595674;38626.42060369153;39272.80363598164;38273.234535308584;38284.42573361346;38296.23407531778;38320.42519362268;38462;32026.679733203302;34041.48937765886;34451;34732.82633586816;34877.476837846945;26427.339316517242;26429;26606.733932660427;26694.19917402481;26769.079427853685 08:51:09 INFO - PROCESS | 15117 | |2;jquery.html;333.78637671889993;336.58768009188765;341.8957218048496;349.5106850409427;362.6464197407528;14467.817080242356;15003.324850381732;17954.371596994093;19384.70922936157;20508.69236961447;18920.1485933133;18969.24123035077;19110.713339299888;19310.90344548279;19358.32245871395;5396.136618141108;5546.223528705985;5793.13103034544;5823.796167134151;5911.320198177222;3678.6689197972178;5816.709164541777;5858.619189752674;5861.413858614147;5866.149408335788;3962.366021436571;3982.900427489307;6318.74725010999;6425.453836423886;6435.51733619978;5687.772489100431;5984.431479009487;6388.872222555546;6400.391962763507;6402.839929001766;5548.389677135512;5558.833235002957;5563.499285064323;5565.860853478655;5570.637908535932;15852.207389630588;20489.38531844047;21366;21483.67774483384;22401.77598224013;2262.0951619352227;2352.9647055294186;2382.6545150953016;2626.658534390517;2738.411241583069;9357.578908949114;9371.109744574254;9505.42967421957;9848.65529706464;10023.649172278936;1815.9636807263912;1852.8147185281498;1933.9129739161772;1937.8062193780509;1958.177565422526;77728.22271777266;78285.60857195678;80518.5974070126;80977.19022809755;82206.58896705537;10092.394456332497;10113.848292275621;10279.640212592523;10477.10944569705;10628.096611788085;14090.929545352208;14092.295385230698;14098.154110753389;14102.083364581269;14153.221572813389;6940.548864323803;7339.412846972229;7360.595167265745;7525.698972041167;7576.924230757732;6676.6661666917435;6743.123393958852;6785.626790526469;7202.099737532809;7219.783406497813;4299.247631664446;4367.10474352757;4410.867673969786;4479.955200448019;4483.775811209426;1802.2160360243336;1808.3941879470262;1845.7323688065155;1871.709884967832;1879.4173806119873;912.1471424218377;914.1498406482035;959.8212058627017;967.7338731848798;967.7967626798311;18146.81853181451;18748.250069997048;18952;19153.808461915203;19502.90248548748;922.9907700923039;960.3229723045237;979.8187335342984;991.177322822056;994.6319861651235;10244.385336879812;10609.628662996913;10826.458677066115;10846.891531084746;10850.29473084247;427432;435641;443040;443659;446406;85873;87830.56084719536;87842.56078719694;88285;88357;927.2257664849791;949.2595775295281;963.5471328475605;969.7527130581657;969.9321047526746;16210.756838647194;16703.665926681155;17010.724195685125;17121.887077339932;17336.65326693484;41205;41747.7912610435;41913;42954.78522607367;43183.78408107939;55136.44863551313;56132.43867561272;56464.717676411354;56582;57760;7946.245106714853;7999.280064793964;8049.154838742082;8075.3135983439715;8368;12057.819132713192;12419.37903104823;12978.351082446028;13036.087473876738;13148;10846.620368287073;10982.0665243452;11498.195126341076;11684.591039313584;11714.062874969812;11080.5567777288;11097.33415995043;11466.885331146581;11530.654080377602;12011.177373317438;11251.662450126509;11413.372264525531;11579.073674105883;11636.825447618123;11827.70430739204;8090.514569125871;8107.959460202661;8230.711925082833;8241.581033943745;8260.463069900437;10195.23535734808;10719.785604287714;10958.780824383308;11602.6519204424;11776.88223117792 08:51:09 INFO - PROCESS | 15117 | |3;mootools.html;1259.7102666386725;1452.6005348529154;1453.5639308207537;1573.5594033670568;1733.9653206935861;6797.2523022467485;7397.556146631199;7668.808279793001;7695.038120234971;7920.445568810185;7744.4966077204945;7815.804604884881;7816.374690024799;7818.983532140814;7820.726274580391;2200.4388880835363;2211.5687440949023;2219.833512486562;2222.69993550871;2229.765874583162;2152;2204.415829805103;2228.5877112734115;2229.0303717882693;2229.7993180613744;2201.1305534313938;2206.8013878750908;2229.877356745378;2232.229880691159;2245.202952951703;2170.522485053286;2186.4424571734266;2204.8566843155145;2208.7791220877866;2210.812080973119;2123.532822778986;2144.946376340604;2180.1715348167754;2183.1267493002765;2183.9344819655275;7389.556626602421;7438.516496427769;7439.739609113709;7447.85104297911;7452.5901075440825;4517.232070548015;4558.8860278492975;4629.930551041737;4630.930536041962;4680.578747912704;2964.2589352661835;3080.645725741546;3136.560881476595;3167.4298626247264;3171.6511183769767;1021.7088129883022;1036.1296510930854;1069.096613361708;1070.769784496337;1094.124700239805;10552.894471055268;10633.893661063368;10677.626283080133;10732.195085368628;10736.946315268373;3971.7418367806;4119.7940102994735;4174.248635245685;4201.390798334224;4201.68487363449;8552.10202928696;8556.57217139153;8559.358048146414;8561.14388561139;8564.74305770828;4773.1408346497965;4777.355057067321;4779.976100119477;4781.832635857798;4783.354247176656;3729.3590820039094;3974.0859602291634;4113.9794301028305;4335.067960388532;4425.09285596452;3235.320582677664;3547.166415892263;3557.48416479609;3565.607783143852;3580.7314451415727;1022.8261195596766;1059.6715018344337;1070.7537266428765;1075.0595175707765;1080.0441609175937;845.6744153500823;877.9692710755093;891.826093911681;929.0987741890356;938.2400255792829;4935.582653525075;5107.795688172506;5376.946230537723;5417.729113544386;5453.781848726086;919.6827094652334;921.7280902133887;930.0978051290238;946.1437399153776;968.2205824311496;3558.1460449491938;3559.4660800880074;3575.213453040327;3601.099725068733;3640.8543658253902;9127;9467.147956683932;9468.479233642078;9485.620575177054;9584.616615335308;9470.431774093577;9474.242060635133;9486.098820612031;9498.050194980447;9501.667441639509;7247.405570774421;7398.297161769623;7407.037085178892;7408.481406301507;7412.332890039922;4867.41591009067;5039.3448851649055;5055.241713742968;5056.241563765465;5271.973640131775;8490.363222758442;8565.700200492953;8575.271101956403;8640.611172497127;8657.437266577652;7849.843003139791;8313.667453302041;8657;8754.737357879274;8776.385653004229;6054.848628784315;6625.238097618835;6729.394354508117;6819.89770153458;6949.861002780017;7607.581583012766;7609.543427394374;7658.540487570764;7667.846643066996;7747.92252077472;6923.515353925177;6940.514164008471;6942;6971.3028697129885;6977;6686.899696504459;6800.965995169992;6806.319368063154;6808.217055038734;6845.452363810784;6284.560080794484;6389.840253993687;6390.936090639034;6391.4247717703765;6399.6800159992745;4369.7159684621665;4506.909861802811;4539.546045395434;4572.1312950539295;4690.577847993697;4578.175928332932;4580.106879158532;4656.161890859677;4724.48030716614;4904.5340692634145 08:51:09 INFO - PROCESS | 15117 | |4;prototype.html;295.5124045325212;302.6897430134112;310.5915720827112;313.9340738444927;318.33309217189986;5041.269015992679;5178.792848286073;5198.220266959953;5236.607254455912;5246.291750613671;5020.523050310224;5115.7697903594335;5157.252198431225;5169;5185.377754669445;4047.494063242095;4073.6537394321517;4073.87778366648;4076.6331030207202;4082.2243773682903;3903.3169195390833;4061.1877624475073;4066.573009833969;4068.3897415387783;4086.5504794472586;4040.3939409088725;4041.4139949707273;4048.2915489789316;4050.160058729819;4053.7770422626745;4026.617471340218;4032.45561849151;4033.6369726724733;4039.878803635881;4047.2310261050307;3562.7149828013958;3588.515550400715;3598.2803439312243;3601.207734298476;3605.7836529808033;4789.616830653575;5038.874028149289;5054.342935418372;5055.317532133152;5065.493450654905;4576.931346029779;4577.359169716243;4580.587747102743;4584.601696482571;4592.655550833668;5420.910081253687;5423.538999185074;5425.755840987165;5436.592255580807;5436.728163591844;3662.322470342995;3844.903877403059;3856.4408160816806;3873.341531939577;3882.8252728627;5594.776208951637;5612.15817627355;5615.66306021636;5616.747246373923;5626.859328516779;3882.3011857865854;3897.7271590988926;3909.843606255775;3930.6069393060466;3933.2920074386884;3868.1490072184074;3926.784026878549;3937.2716047530726;3973.5231772186944;3976.1848820991627;4526.660500462479;4537.886552836206;4547.909041819145;4549.7042692224895;4552.339910712928;5350.652207606571;5383.327084114486;5385.7576409061685;5398.6220964532895;5401;1305.9151155174884;1326.7678156322604;1343.7581235377531;1343.8521762606106;1348.1506650809927;918.5131880103556;935.4480856294683;937.7983733497331;940.1820416237916;943.8772959515356;5160.297101956346;5176.670498275791;5186.392218412304;5187.584993200535;5225.634205605571;5293.570735901362;5502.779888804403;5510.669359838423;5514.862128446821;5523.309586301712;5202.375714914158;5226.484319547365;5230.326295585376;5232.2413250078525;5232.3459567554055;2573.597389422769;2577.329894227477;2579.8065145113815;2590.080521414908;2599.415131595376;5042.773075211624;5426.565874730012;5763.7982670606325;5782.913256301159;5830;5653.604247702621;5666.829995100154;5712.80005199816;5717.599768016282;5748.396418376094;5653.925754106789;5748.971255143698;5750.166225897305;5831;5850.414958504116;5529.511719726059;5552.416996215339;5574.108142697149;5578.246936663499;5588.357338905916;5523.392426833126;5531.1426728857095;5535.723213839373;5570.916436253378;5587.413321601173;5658.350364015269;5752.597318187687;5785.0454674978155;5792.333881603669;5823.126531020381;3968.265870813909;4007.779572123561;4015.9598404015587;4016.2770701274053;4020.979895100506;5490.258815060076;5493.505584497414;5510.366307874646;5520.585956053232;5534.695591742493;5227.778194267497;5416.322959630046;5437.26596909428;5502.284702988586;5519.503244707996;5216.9739151304;5446.782128714807;5473;5490.862728431821;5507.173923911445;5249.477651481027;5328.108521474821;5361.51746342831;5382.623216374816;5395.56835453155;5403.270558474555;5407.432219617041;5451.1466101525675;5457.372402173642;5469.097598896296;5146.716930568855;5322.707251101227;5341.4925582069645;5354.3574771027725;5359 08:51:09 INFO - PROCESS | 15117 | |5;yui.html;746.2276543777192;752.6048824367207;777.5089846588818;803.1286054630725;871.1288711288713;14226;15085.170315632637;15296.464623738171;15500.147491887941;15602.453914113008;13704.657383565416;14023.158610483353;14043.157410555348;14051.929740351285;14067.366968486416;663.4228221447347;799.9360051195905;810.7770363150122;811.37524106438;811.6915572082601;677.9593224406527;798.656577671601;809.4778867630375;815.5555222403805;817.1828171828172;850.3537311643134;852.9488230706178;853.2875049333783;853.3855623950745;853.4495250563383;686.1046334533432;847.1697736218509;850.7320194138888;850.7617866997219;851.3359579527947;513.4711247415169;604.3956043956044;617.1575799034331;619.2074145094286;621.6891554222889;13895.79156312656;13898.444062237499;13924.234167120805;13927.512537061255;13933.512327068605;12150.45322960469;12366.75266494674;12487;12692.428840702098;12708.618741437771;11971.94014029933;11992;12158.878411215863;12240.265584064895;12608.11743177978;4276.358546218061;4287.571242875719;4307.073979094478;4536.841210557614;4547.090581883604;60843;61452;61856.99999999955;61902;63005.36994630041;9911.207103431709;9924.950375248078;9952.751181220383;10017.69946901594;10159.644412445528;17891.01599412019;17922.19350129221;17939.641207175784;17948.910255448638;17964.371247006555;7613.695452181962;7714.845703086019;7775.455718099792;7830.2952734254195;7998.320142787812;4389;4413.360062790877;4436.467623885154;4470.932936005963;4483.50681425043;3064.509678451437;3087.371110956464;3087.969120308813;3088.3977624363483;3090.3510262844607;518.4219595151454;518.6343627742433;521.499360613815;529.6477842234871;534.1240365800091;608.3794529579803;646.7380710812129;672.7208208593379;680.6732768271158;720.8486217894301;8253.546054967035;8273.420860539825;8573.485590864568;8598.78503037429;8962.82074358509;553.4852587094041;584.8216294030276;587.6709042935884;602.0050250006271;673.2056173714965;3993.7803420812133;4077.895726622633;4165.58344165581;4278.294081476583;4345.9130817383475;76530;81259.59370203229;81306.78039829407;82554;84047;66575;68267;68414.31585684179;70129.2987070133;73340;62351;65250;65605.67197163984;65840;65922.67038664872;8032.437729358889;8175.223353781381;8227;8380.20388063133;8381.980833217296;45311.77344113258;45628.54371456243;46153.76923115363;46532.7673361631;46922.765386172854;56146.43853561412;60679;61654.38345616486;62174;63173;10172.440515771703;10326.586936522455;10330.276880618285;10416.895831041593;10515.474226288501;12034.338111403957;12317.137800353888;12342.259464431803;12405.379731013594;12709.872901270868;13002.154859934075;13050.804237936249;13377.464901403835;13727.725445491234;14187.716245675236;12523.49906003786;13012.739745205232;13194.142380745221;13691.589252322447;14072.296385180905;11966.999305406434;12328.630141095782;12490.795103990158;12513.499460021862;12627.179233349803;10683.412412317397;10724.946375268073;10800.981180714192;11076.335419874833;11295.604653837405;9849.556769945226;11249.268797528463;11332.206745527734;11529.711757206136;11533.769324613628 08:51:09 INFO - PROCESS | 15117 | __end_tp_report 08:51:09 INFO - PROCESS | 15117 | __start_cc_report 08:51:09 INFO - PROCESS | 15117 | _x_x_mozilla_cycle_collect,2220 08:51:09 INFO - PROCESS | 15117 | __end_cc_report 08:51:09 INFO - PROCESS | 15117 | __startTimestamp1478188269324__endTimestamp 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | ------- Summary: start ------- 08:51:09 INFO - PROCESS | 15117 | Number of tests: 6 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | [#0] dojo.html Cycles:165 Average:5268.45 Median:5497.20 stddev:611.95 (11.1%) stddev-sans-first:585.89 08:51:09 INFO - PROCESS | 15117 | Values: 2938.3 2970.0 2993.0 3001.9 3014.8 5212.6 5279.2 5300.5 5343.2 5435.2 5192.4 5208.1 5230.1 5325.3 5329.9 4764.2 4794.0 4842.6 4844.1 4863.8 4815.7 4861.1 4879.6 4882.1 4944.8 4761.5 4900.6 4906.0 4954.3 4978.7 4799.7 4861.5 4865.2 4867.8 4869.6 4842.5 4854.6 4860.3 4862.4 4869.1 5246.8 5296.9 5297.5 5299.4 5312.5 5673.1 5684.2 5694.6 5698.7 5702.8 5709.2 5736.7 5740.7 5753.5 5757.6 5315.2 5357.2 5363.4 5365.7 5370.4 5745.9 5749.8 5770.7 5834.6 5845.0 5580.1 5594.2 5603.7 5604.1 5606.0 5516.1 5551.4 5554.3 5634.0 5670.2 5611.6 5616.9 5624.0 5624.3 5626.0 5598.2 5609.6 5632.1 5644.4 5654.0 4331.3 4339.6 4342.5 4344.1 4344.3 3495.6 3844.3 3848.3 3903.3 3916.7 5360.6 5365.4 5419.1 5427.7 5430.5 5620.5 5695.1 5699.3 5701.5 5735.9 5217.5 5263.8 5358.0 5361.5 5420.4 4713.3 4726.8 4739.4 4762.4 4834.3 5862.4 5873.8 5874.1 5875.9 5883.4 5631.8 5640.4 5641.7 5654.3 5654.5 5698.8 5743.2 5851.0 5925.8 5936.9 5592.7 5639.9 5642.7 5643.3 5703.7 5688.3 5739.3 5743.5 5748.3 5762.2 5453.6 5497.0 5497.2 5575.0 5601.8 5561.1 5572.3 5572.3 5575.6 5581.4 5533.5 5546.4 5556.7 5559.8 5565.2 5524.6 5560.8 5564.1 5566.1 5568.5 5435.3 5447.0 5450.4 5457.9 5458.8 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | [#1] ext.html Cycles:180 Average:57061.66 Median:34721.65 stddev:110267.91 (317.6%) stddev-sans-first:110495.70 08:51:09 INFO - PROCESS | 15117 | Values: 581.8 598.9 604.5 604.8 609.3 31842.2 42064.8 43073.1 43523.6 47042.8 38844.8 39516.2 39589.0 39885.4 39903.0 8048.0 8809.8 8956.6 8957.9 8971.7 8171.7 10466.3 10711.8 10716.9 11133.7 10821.2 10884.5 10885.5 10889.8 10890.9 10620.2 10647.7 10687.6 10714.4 10715.9 10545.4 10603.2 10604.7 10611.5 10613.2 41438.0 41716.0 41721.8 41732.4 41769.2 3338.1 3390.4 3411.4 3415.1 3453.3 31298.2 31538.5 31830.0 32852.5 32926.0 4018.6 4029.0 4109.7 4261.2 4265.4 328567.0 329971.0 331513.0 332479.3 332622.0 57463.7 57826.4 57924.2 57948.0 58585.4 58560.0 58891.0 63689.0 63786.7 63790.0 15554.7 15714.3 15751.7 15839.5 15866.1 10601.9 10816.0 11141.8 11626.7 11909.2 18913.1 19775.9 20065.3 20093.7 20135.8 7237.3 7522.8 7583.9 7660.3 7720.8 966.8 1124.9 1134.0 1154.1 1172.3 31091.0 31898.7 32835.3 34710.5 35206.0 1020.0 1091.6 1143.4 1155.2 1195.7 15633.2 16386.3 16528.5 16558.3 16716.7 499523.0 504291.0 505307.0 505580.0 505800.0 54757.0 54826.2 55023.0 55179.0 55554.0 1221.3 1226.5 1280.7 1328.7 1374.6 27989.4 31847.7 32363.4 32396.5 32589.5 48297.0 48892.3 49230.3 49291.3 49344.0 392703.0 397736.0 397793.3 397896.0 398237.0 25446.5 26188.2 27181.6 28078.7 28339.0 42597.8 43319.6 43382.0 43809.1 44323.3 37433.6 37566.8 38069.8 38179.2 38300.0 37144.3 37642.8 38276.8 38626.4 39272.8 38273.2 38284.4 38296.2 38320.4 38462.0 32026.7 34041.5 34451.0 34732.8 34877.5 26427.3 26429.0 26606.7 26694.2 26769.1 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | [#2] jquery.html Cycles:180 Average:27044.61 Median:41830.40 stddev:72667.48 (173.7%) stddev-sans-first:72843.66 08:51:09 INFO - PROCESS | 15117 | Values: 333.8 336.6 341.9 349.5 362.6 14467.8 15003.3 17954.4 19384.7 20508.7 18920.1 18969.2 19110.7 19310.9 19358.3 5396.1 5546.2 5793.1 5823.8 5911.3 3678.7 5816.7 5858.6 5861.4 5866.1 3962.4 3982.9 6318.7 6425.5 6435.5 5687.8 5984.4 6388.9 6400.4 6402.8 5548.4 5558.8 5563.5 5565.9 5570.6 15852.2 20489.4 21366.0 21483.7 22401.8 2262.1 2353.0 2382.7 2626.7 2738.4 9357.6 9371.1 9505.4 9848.7 10023.6 1816.0 1852.8 1933.9 1937.8 1958.2 77728.2 78285.6 80518.6 80977.2 82206.6 10092.4 10113.8 10279.6 10477.1 10628.1 14090.9 14092.3 14098.2 14102.1 14153.2 6940.5 7339.4 7360.6 7525.7 7576.9 6676.7 6743.1 6785.6 7202.1 7219.8 4299.2 4367.1 4410.9 4480.0 4483.8 1802.2 1808.4 1845.7 1871.7 1879.4 912.1 914.1 959.8 967.7 967.8 18146.8 18748.3 18952.0 19153.8 19502.9 923.0 960.3 979.8 991.2 994.6 10244.4 10609.6 10826.5 10846.9 10850.3 427432.0 435641.0 443040.0 443659.0 446406.0 85873.0 87830.6 87842.6 88285.0 88357.0 927.2 949.3 963.5 969.8 969.9 16210.8 16703.7 17010.7 17121.9 17336.7 41205.0 41747.8 41913.0 42954.8 43183.8 55136.4 56132.4 56464.7 56582.0 57760.0 7946.2 7999.3 8049.2 8075.3 8368.0 12057.8 12419.4 12978.4 13036.1 13148.0 10846.6 10982.1 11498.2 11684.6 11714.1 11080.6 11097.3 11466.9 11530.7 12011.2 11251.7 11413.4 11579.1 11636.8 11827.7 8090.5 8108.0 8230.7 8241.6 8260.5 10195.2 10719.8 10958.8 11602.7 11776.9 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | [#3] mootools.html Cycles:180 Average:5097.93 Median:4920.06 stddev:2795.47 (56.8%) stddev-sans-first:2788.43 08:51:09 INFO - PROCESS | 15117 | Values: 1259.7 1452.6 1453.6 1573.6 1734.0 6797.3 7397.6 7668.8 7695.0 7920.4 7744.5 7815.8 7816.4 7819.0 7820.7 2200.4 2211.6 2219.8 2222.7 2229.8 2152.0 2204.4 2228.6 2229.0 2229.8 2201.1 2206.8 2229.9 2232.2 2245.2 2170.5 2186.4 2204.9 2208.8 2210.8 2123.5 2144.9 2180.2 2183.1 2183.9 7389.6 7438.5 7439.7 7447.9 7452.6 4517.2 4558.9 4629.9 4630.9 4680.6 2964.3 3080.6 3136.6 3167.4 3171.7 1021.7 1036.1 1069.1 1070.8 1094.1 10552.9 10633.9 10677.6 10732.2 10736.9 3971.7 4119.8 4174.2 4201.4 4201.7 8552.1 8556.6 8559.4 8561.1 8564.7 4773.1 4777.4 4780.0 4781.8 4783.4 3729.4 3974.1 4114.0 4335.1 4425.1 3235.3 3547.2 3557.5 3565.6 3580.7 1022.8 1059.7 1070.8 1075.1 1080.0 845.7 878.0 891.8 929.1 938.2 4935.6 5107.8 5376.9 5417.7 5453.8 919.7 921.7 930.1 946.1 968.2 3558.1 3559.5 3575.2 3601.1 3640.9 9127.0 9467.1 9468.5 9485.6 9584.6 9470.4 9474.2 9486.1 9498.1 9501.7 7247.4 7398.3 7407.0 7408.5 7412.3 4867.4 5039.3 5055.2 5056.2 5272.0 8490.4 8565.7 8575.3 8640.6 8657.4 7849.8 8313.7 8657.0 8754.7 8776.4 6054.8 6625.2 6729.4 6819.9 6949.9 7607.6 7609.5 7658.5 7667.8 7747.9 6923.5 6940.5 6942.0 6971.3 6977.0 6686.9 6801.0 6806.3 6808.2 6845.5 6284.6 6389.8 6390.9 6391.4 6399.7 4369.7 4506.9 4539.5 4572.1 4690.6 4578.2 4580.1 4656.2 4724.5 4904.5 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | [#4] prototype.html Cycles:180 Average:4547.75 Median:5221.30 stddev:1357.79 (26.0%) stddev-sans-first:1323.55 08:51:09 INFO - PROCESS | 15117 | Values: 295.5 302.7 310.6 313.9 318.3 5041.3 5178.8 5198.2 5236.6 5246.3 5020.5 5115.8 5157.3 5169.0 5185.4 4047.5 4073.7 4073.9 4076.6 4082.2 3903.3 4061.2 4066.6 4068.4 4086.6 4040.4 4041.4 4048.3 4050.2 4053.8 4026.6 4032.5 4033.6 4039.9 4047.2 3562.7 3588.5 3598.3 3601.2 3605.8 4789.6 5038.9 5054.3 5055.3 5065.5 4576.9 4577.4 4580.6 4584.6 4592.7 5420.9 5423.5 5425.8 5436.6 5436.7 3662.3 3844.9 3856.4 3873.3 3882.8 5594.8 5612.2 5615.7 5616.7 5626.9 3882.3 3897.7 3909.8 3930.6 3933.3 3868.1 3926.8 3937.3 3973.5 3976.2 4526.7 4537.9 4547.9 4549.7 4552.3 5350.7 5383.3 5385.8 5398.6 5401.0 1305.9 1326.8 1343.8 1343.9 1348.2 918.5 935.4 937.8 940.2 943.9 5160.3 5176.7 5186.4 5187.6 5225.6 5293.6 5502.8 5510.7 5514.9 5523.3 5202.4 5226.5 5230.3 5232.2 5232.3 2573.6 2577.3 2579.8 2590.1 2599.4 5042.8 5426.6 5763.8 5782.9 5830.0 5653.6 5666.8 5712.8 5717.6 5748.4 5653.9 5749.0 5750.2 5831.0 5850.4 5529.5 5552.4 5574.1 5578.2 5588.4 5523.4 5531.1 5535.7 5570.9 5587.4 5658.4 5752.6 5785.0 5792.3 5823.1 3968.3 4007.8 4016.0 4016.3 4021.0 5490.3 5493.5 5510.4 5520.6 5534.7 5227.8 5416.3 5437.3 5502.3 5519.5 5217.0 5446.8 5473.0 5490.9 5507.2 5249.5 5328.1 5361.5 5382.6 5395.6 5403.3 5407.4 5451.1 5457.4 5469.1 5146.7 5322.7 5341.5 5354.4 5359.0 08:51:09 INFO - PROCESS | 15117 | 08:51:09 INFO - PROCESS | 15117 | [#5] yui.html Cycles:180 Average:16964.97 Median:23718.12 stddev:22138.86 (93.3%) stddev-sans-first:22167.47 08:51:09 INFO - PROCESS | 15117 | Values: 746.2 752.6 777.5 803.1 871.1 14226.0 15085.2 15296.5 15500.1 15602.5 13704.7 14023.2 14043.2 14051.9 14067.4 663.4 799.9 810.8 811.4 811.7 678.0 798.7 809.5 815.6 817.2 850.4 852.9 853.3 853.4 853.4 686.1 847.2 850.7 850.8 851.3 513.5 604.4 617.2 619.2 621.7 13895.8 13898.4 13924.2 13927.5 13933.5 12150.5 12366.8 12487.0 12692.4 12708.6 11971.9 11992.0 12158.9 12240.3 12608.1 4276.4 4287.6 4307.1 4536.8 4547.1 60843.0 61452.0 61857.0 61902.0 63005.4 9911.2 9925.0 9952.8 10017.7 10159.6 17891.0 17922.2 17939.6 17948.9 17964.4 7613.7 7714.8 7775.5 7830.3 7998.3 4389.0 4413.4 4436.5 4470.9 4483.5 3064.5 3087.4 3088.0 3088.4 3090.4 518.4 518.6 521.5 529.6 534.1 608.4 646.7 672.7 680.7 720.8 8253.5 8273.4 8573.5 8598.8 8962.8 553.5 584.8 587.7 602.0 673.2 3993.8 4077.9 4165.6 4278.3 4345.9 76530.0 81259.6 81306.8 82554.0 84047.0 66575.0 68267.0 68414.3 70129.3 73340.0 62351.0 65250.0 65605.7 65840.0 65922.7 8032.4 8175.2 8227.0 8380.2 8382.0 45311.8 45628.5 46153.8 46532.8 46922.8 56146.4 60679.0 61654.4 62174.0 63173.0 10172.4 10326.6 10330.3 10416.9 10515.5 12034.3 12317.1 12342.3 12405.4 12709.9 13002.2 13050.8 13377.5 13727.7 14187.7 12523.5 13012.7 13194.1 13691.6 14072.3 11967.0 12328.6 12490.8 12513.5 12627.2 10683.4 10724.9 10801.0 11076.3 11295.6 9849.6 11249.3 11332.2 11529.7 11533.8 08:51:09 INFO - PROCESS | 15117 | -------- Summary: end -------- 08:51:09 INFO - PROCESS | 15117 | 08:51:10 INFO - TEST-INFO | 15117: exit 0 08:51:10 INFO - TEST-OK | dromaeo_css | took 1119616ms 08:51:10 INFO - TEST-START | kraken 08:51:10 INFO - operating with platform_type : linux_ 08:51:10 INFO - Initialising browser for kraken test... 08:51:10 INFO - TEST-INFO | started process 15423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5nZ5HA/profile http://localhost:33728/getInfo.html) 08:51:14 INFO - PROCESS | 15423 | __metrics Screen width/height:1600/1200 08:51:14 INFO - PROCESS | 15423 | colorDepth:24 08:51:14 INFO - PROCESS | 15423 | Browser inner width/height: 1024/697 08:51:14 INFO - PROCESS | 15423 | __metrics 08:51:14 INFO - PROCESS | 15423 | 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" 08:51:14 INFO - PROCESS | 15423 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:15 INFO - PROCESS | 15423 | console.error: PushService: 08:51:15 INFO - PROCESS | 15423 | stateChangeProcessEnqueue: Error transitioning state 08:51:15 INFO - PROCESS | 15423 | UnknownError 08:51:16 INFO - TEST-INFO | 15423: exit 0 08:51:16 INFO - Browser initialized. 08:51:16 INFO - Running cycle 1/1 for kraken test... 08:51:16 INFO - TEST-INFO | started process 15505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5nZ5HA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:28 INFO - PROCESS | 15505 | RSS: Main: 173170688 08:51:28 INFO - PROCESS | 15505 | 08:51:30 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:31 INFO - PROCESS | 15505 | RSS: Main: 229445632 08:51:31 INFO - PROCESS | 15505 | 08:51:34 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-dft) 08:51:34 INFO - PROCESS | 15505 | RSS: Main: 217145344 08:51:34 INFO - PROCESS | 15505 | 08:51:38 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-fft) 08:51:38 INFO - PROCESS | 15505 | RSS: Main: 298332160 08:51:38 INFO - PROCESS | 15505 | 08:51:40 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33728/tests/kraken/driver.html?testName=audio-oscillator) 08:51:41 INFO - PROCESS | 15505 | RSS: Main: 207695872 08:51:41 INFO - PROCESS | 15505 | 08:51:43 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33728/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:51:44 INFO - PROCESS | 15505 | RSS: Main: 213868544 08:51:44 INFO - PROCESS | 15505 | 08:51:47 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33728/tests/kraken/driver.html?testName=imaging-darkroom) 08:51:47 INFO - PROCESS | 15505 | RSS: Main: 248672256 08:51:47 INFO - PROCESS | 15505 | 08:51:50 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33728/tests/kraken/driver.html?testName=imaging-desaturate) 08:51:51 INFO - PROCESS | 15505 | RSS: Main: 247627776 08:51:51 INFO - PROCESS | 15505 | 08:51:54 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33728/tests/kraken/driver.html?testName=json-parse-financial) 08:51:54 INFO - PROCESS | 15505 | RSS: Main: 247173120 08:51:54 INFO - PROCESS | 15505 | 08:51:56 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33728/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:51:56 INFO - PROCESS | 15505 | RSS: Main: 209858560 08:51:56 INFO - PROCESS | 15505 | 08:51:58 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:51:59 INFO - PROCESS | 15505 | RSS: Main: 217346048 08:51:59 INFO - PROCESS | 15505 | 08:52:01 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:01 INFO - PROCESS | 15505 | RSS: Main: 226889728 08:52:01 INFO - PROCESS | 15505 | 08:52:04 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:05 INFO - PROCESS | 15505 | RSS: Main: 235126784 08:52:05 INFO - PROCESS | 15505 | 08:52:08 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:08 INFO - PROCESS | 15505 | RSS: Main: 231886848 08:52:08 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | Cycle 1(1): loaded http://localhost:33728/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33728/tests/kraken/driver.html?testName=ai-astar) 08:52:10 INFO - PROCESS | 15505 | RSS: Main: 282517504 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | __start_tp_report 08:52:10 INFO - PROCESS | 15505 | _x_x_mozilla_page_load 08:52:10 INFO - PROCESS | 15505 | _x_x_mozilla_page_load_details 08:52:10 INFO - PROCESS | 15505 | |i|pagename|runs| 08:52:10 INFO - PROCESS | 15505 | |0;ai-astar;105;113;113;112;112;112;114;113;112;114 08:52:10 INFO - PROCESS | 15505 | |1;audio-beat-detection;151;128;130;169;125;126;121;123;158;128 08:52:10 INFO - PROCESS | 15505 | |2;audio-dft;160;162;160;161;161;161;162;160;160;161 08:52:10 INFO - PROCESS | 15505 | |3;audio-fft;76;75;75;106;76;77;76;75;98;76 08:52:10 INFO - PROCESS | 15505 | |4;audio-oscillator;82;83;110;82;82;81;111;83;83;122 08:52:10 INFO - PROCESS | 15505 | |5;imaging-gaussian-blur;116;117;117;117;117;116;119;117;118;117 08:52:10 INFO - PROCESS | 15505 | |6;imaging-darkroom;145;144;146;146;145;145;146;145;145;145 08:52:10 INFO - PROCESS | 15505 | |7;imaging-desaturate;84;85;84;85;84;84;84;85;84;84 08:52:10 INFO - PROCESS | 15505 | |8;json-parse-financial;53;56;51;52;53;52;59;52;53;53 08:52:10 INFO - PROCESS | 15505 | |9;json-stringify-tinderbox;61;61;60;61;61;61;60;61;60;61 08:52:10 INFO - PROCESS | 15505 | |10;stanford-crypto-aes;79;80;82;79;92;78;80;79;80;80 08:52:10 INFO - PROCESS | 15505 | |11;stanford-crypto-ccm;131;139;138;139;137;132;132;128;173;136 08:52:10 INFO - PROCESS | 15505 | |12;stanford-crypto-pbkdf2;167;163;163;165;162;164;163;174;163;166 08:52:10 INFO - PROCESS | 15505 | |13;stanford-crypto-sha256-iterative;66;62;64;64;64;63;64;62;63;63 08:52:10 INFO - PROCESS | 15505 | __end_tp_report 08:52:10 INFO - PROCESS | 15505 | __start_cc_report 08:52:10 INFO - PROCESS | 15505 | _x_x_mozilla_cycle_collect,1682 08:52:10 INFO - PROCESS | 15505 | __end_cc_report 08:52:10 INFO - PROCESS | 15505 | __startTimestamp1478188330524__endTimestamp 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | ------- Summary: start ------- 08:52:10 INFO - PROCESS | 15505 | Number of tests: 14 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:2.58 (2.3%) stddev-sans-first:0.83 08:52:10 INFO - PROCESS | 15505 | Values: 105.0 113.0 113.0 112.0 112.0 112.0 114.0 113.0 112.0 114.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:129.00 stddev:16.92 (13.1%) stddev-sans-first:17.04 08:52:10 INFO - PROCESS | 15505 | Values: 151.0 128.0 130.0 169.0 125.0 126.0 121.0 123.0 158.0 128.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 08:52:10 INFO - PROCESS | 15505 | Values: 160.0 162.0 160.0 161.0 161.0 161.0 162.0 160.0 160.0 161.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.24 (14.8%) stddev-sans-first:11.78 08:52:10 INFO - PROCESS | 15505 | Values: 76.0 75.0 75.0 106.0 76.0 77.0 76.0 75.0 98.0 76.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:82.00 stddev:15.81 (19.3%) stddev-sans-first:16.36 08:52:10 INFO - PROCESS | 15505 | Values: 82.0 83.0 110.0 82.0 82.0 81.0 111.0 83.0 83.0 122.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.88 (0.7%) stddev-sans-first:0.83 08:52:10 INFO - PROCESS | 15505 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 119.0 117.0 118.0 117.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:52:10 INFO - PROCESS | 15505 | Values: 145.0 144.0 146.0 146.0 145.0 145.0 146.0 145.0 145.0 145.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 08:52:10 INFO - PROCESS | 15505 | Values: 84.0 85.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:2.37 (4.5%) stddev-sans-first:2.51 08:52:10 INFO - PROCESS | 15505 | Values: 53.0 56.0 51.0 52.0 53.0 52.0 59.0 52.0 53.0 53.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 08:52:10 INFO - PROCESS | 15505 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 60.0 61.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:4.04 (5.1%) stddev-sans-first:4.23 08:52:10 INFO - PROCESS | 15505 | Values: 79.0 80.0 82.0 79.0 92.0 78.0 80.0 79.0 80.0 80.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#11] stanford-crypto-ccm Cycles:10 Average:138.50 Median:137.50 stddev:12.70 (9.2%) stddev-sans-first:13.17 08:52:10 INFO - PROCESS | 15505 | Values: 131.0 139.0 138.0 139.0 137.0 132.0 132.0 128.0 173.0 136.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:164.50 stddev:3.53 (2.1%) stddev-sans-first:3.67 08:52:10 INFO - PROCESS | 15505 | Values: 167.0 163.0 163.0 165.0 162.0 164.0 163.0 174.0 163.0 166.0 08:52:10 INFO - PROCESS | 15505 | 08:52:10 INFO - PROCESS | 15505 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:1.18 (1.8%) stddev-sans-first:0.83 08:52:10 INFO - PROCESS | 15505 | Values: 66.0 62.0 64.0 64.0 64.0 63.0 64.0 62.0 63.0 63.0 08:52:10 INFO - PROCESS | 15505 | -------- Summary: end -------- 08:52:10 INFO - PROCESS | 15505 | 08:52:11 INFO - TEST-INFO | 15505: exit 0 08:52:11 INFO - TEST-OK | kraken | took 61425ms 08:52:11 INFO - SUITE-END | took 1181s 08:52:12 INFO - Completed test suite (00:19:41) 08:52:12 INFO - javascript benchmark 08:52:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2938.338873753405, 2969.9851500742493, 2992.985035074825, 3001.939961200776, 3014.773891958104, 5212.582993360532, 5279.155335146377, 5300.469953004697, 5343.225232341309, 5435.157550579656, 5192.402873669529, 5208.062548741225, 5230.1108811502045, 5325.334333208349, 5329.920051199235, 4764.166270902596, 4794.0, 4842.564169224769, 4844.07962487128, 4863.805447782084, 4815.735134567597, 4861.124997500448, 4879.585235255007, 4882.121218180726, 4944.752762361885, 4761.500042495557, 4900.632452566037, 4906.043321552299, 4954.331165292693, 4978.6514943953935, 4799.664023518355, 4861.513848615145, 4865.221564549655, 4867.780949857265, 4869.634777391674, 4842.539958703917, 4854.6359023073055, 4860.343853579757, 4862.3922009748785, 4869.074875773592, 5246.81636142737, 5296.947030529684, 5297.47025297471, 5299.390570084451, 5312.4687531246955, 5673.063944449161, 5684.2326285951285, 5694.572907031989, 5698.715064246812, 5702.771889124471, 5709.200711900337, 5736.713164341766, 5740.684262365568, 5753.510951569122, 5757.596968212227, 5315.202719592054, 5357.223202635635, 5363.383210930754, 5365.678059316453, 5370.382406023279, 5745.913811292834, 5749.8275051748515, 5770.653760774367, 5834.649921004753, 5845.035569131131, 5580.051391263495, 5594.216809646653, 5603.663780173121, 5604.075327570987, 5606.0, 5516.117421212587, 5551.3893471718075, 5554.250176226238, 5634.0, 5670.206171136044, 5611.551075913917, 5616.9157462638095, 5624.0439125348785, 5624.268845050117, 5626.0, 5598.216249725042, 5609.5792815539, 5632.070708333161, 5644.379118296984, 5654.0, 4331.328644060176, 4339.587739164775, 4342.522322544518, 4344.087741574304, 4344.304911214191, 3495.563054618173, 3844.308024555551, 3848.3073046851837, 3903.316919539126, 3916.74541154824, 5360.624756267024, 5365.409804921455, 5419.051665958442, 5427.674339539641, 5430.5384042356845, 5620.49415552594, 5695.145728140812, 5699.344575373802, 5701.515371193412, 5735.942640573624, 5217.50433708797, 5263.815766448156, 5358.0, 5361.490658387447, 5420.430854760193, 4713.316569097462, 4726.834560790356, 4739.3838800955655, 4762.3570817939135, 4834.347363106006, 5862.355140934494, 5873.823785286449, 5874.060150375919, 5875.941240587539, 5883.382244864228, 5631.831045068655, 5640.4077571856005, 5641.661500309994, 5654.321481422256, 5654.46282603152, 5698.831739493311, 5743.195952566561, 5851.034579294369, 5925.822225333247, 5936.910946335895, 5592.692401917933, 5639.915401268902, 5642.6614403135945, 5643.266375371176, 5703.7433315500075, 5688.345840228261, 5739.282589676291, 5743.511801496919, 5748.252727145445, 5762.2221000164445, 5453.61824672285, 5497.038018346853, 5497.202905578749, 5574.9721251393485, 5601.80393686219, 5561.110222364402, 5572.275604171432, 5572.331320241597, 5575.581831362745, 5581.358143813513, 5533.529649979797, 5546.4453554644215, 5556.694381808878, 5559.833205003856, 5565.220869078414, 5524.558035357081, 5560.777568897361, 5564.054110801255, 5566.053770859045, 5568.470995255444, 5435.266239057834, 5447.0, 5450.427705090909, 5457.890842183055, 5458.781648734165], "value": 5225.457503665097, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.8429024163476, 598.9071693887447, 604.5435696049482, 604.770187328815, 609.3449541742622, 31842.20394490136, 42064.789676051616, 43073.13853722928, 43523.56476435235, 47042.76478617611, 38844.80577597115, 39516.209675806465, 39589.010274743145, 39885.40171897424, 39903.0, 8047.95976020122, 8809.823803523926, 8956.552172391386, 8957.910420895805, 8971.730848074536, 8171.67313307467, 10466.267361284714, 10711.83932241017, 10716.946415267952, 11133.665990020312, 10821.242513024092, 10884.510197041152, 10885.455727213608, 10889.83665245022, 10890.945545272263, 10620.15038796902, 10647.680569582924, 10687.625933092304, 10714.357138571671, 10715.946420267926, 10545.367277963347, 10603.204759643058, 10604.681859544226, 10611.469426528643, 10613.150947924147, 41438.0, 41716.0, 41721.79139104315, 41732.37401438981, 41769.1646167078, 3338.115399419156, 3390.4066788311948, 3411.4371128763723, 3415.1291420687567, 3453.2748122894222, 31298.21754456134, 31538.526922096185, 31830.0, 32852.507212391836, 32926.0, 4018.57804930481, 4028.979855100735, 4109.691773117028, 4261.190373828963, 4265.3815196796295, 328567.0, 329971.0, 331513.0, 332479.33760331286, 332622.0, 57463.71268143632, 57826.42173578295, 57924.23492472976, 57948.0, 58585.41414585885, 58560.0, 58891.0, 63689.0, 63786.68106659437, 63790.043149352794, 15554.688906221812, 15714.29285682147, 15751.68496630061, 15839.524814255361, 15866.127362995147, 10601.946990265, 10816.0, 11141.777164456827, 11626.70933226676, 11909.22590031645, 18913.14890829916, 19775.912324821984, 20065.29771457992, 20093.698594521094, 20135.798642013393, 7237.312455316842, 7522.811929701801, 7583.886241706379, 7660.310572048543, 7720.845583088307, 966.8066386722684, 1124.876263611002, 1133.9716507087223, 1154.0709728668335, 1172.267332916927, 31091.0, 31898.681013189573, 32835.34329313448, 34710.47934280988, 35206.0, 1019.9698304712146, 1091.5984833366624, 1143.4397145398696, 1155.1798223261578, 1195.7190060335813, 15633.218339083, 16386.26261818221, 16528.504144875675, 16558.254878530493, 16716.74924876128, 499523.0, 504291.0, 505307.0, 505580.0, 505800.0, 54757.0, 54826.17760733592, 55023.0, 55179.0, 55554.0, 1221.3404761428906, 1226.533917111492, 1280.6862318731785, 1328.7342531493546, 1374.5738820965532, 27989.440211195255, 31847.721020150566, 32363.35273294568, 32396.514052288763, 32589.511157333134, 48297.0, 48892.26661600007, 49230.261546077556, 49291.26063109128, 49344.0, 392703.0, 397736.0, 397793.3420319855, 397896.0, 398237.0, 25446.491070178123, 26188.214353568663, 27181.59227611548, 28078.719212808428, 28339.0, 42597.787011065986, 43319.56680433281, 43382.0, 43809.12381752411, 44323.33514997342, 37433.62566374301, 37566.812165938994, 38069.80965095157, 38179.236415270985, 38300.0, 37144.25711485809, 37642.81178594199, 38276.80861595674, 38626.42060369153, 39272.80363598164, 38273.234535308584, 38284.42573361346, 38296.23407531778, 38320.42519362268, 38462.0, 32026.679733203302, 34041.48937765886, 34451.0, 34732.82633586816, 34877.476837846945, 26427.339316517242, 26429.0, 26606.733932660427, 26694.19917402481, 26769.079427853685], "value": 19884.78572605537, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.78637671889993, 336.58768009188765, 341.8957218048496, 349.5106850409427, 362.6464197407528, 14467.817080242356, 15003.324850381732, 17954.371596994093, 19384.70922936157, 20508.69236961447, 18920.1485933133, 18969.24123035077, 19110.713339299888, 19310.90344548279, 19358.32245871395, 5396.136618141108, 5546.223528705985, 5793.13103034544, 5823.796167134151, 5911.320198177222, 3678.6689197972178, 5816.709164541777, 5858.619189752674, 5861.413858614147, 5866.149408335788, 3962.366021436571, 3982.900427489307, 6318.74725010999, 6425.453836423886, 6435.51733619978, 5687.772489100431, 5984.431479009487, 6388.872222555546, 6400.391962763507, 6402.839929001766, 5548.389677135512, 5558.833235002957, 5563.499285064323, 5565.860853478655, 5570.637908535932, 15852.207389630588, 20489.38531844047, 21366.0, 21483.67774483384, 22401.77598224013, 2262.0951619352227, 2352.9647055294186, 2382.6545150953016, 2626.658534390517, 2738.411241583069, 9357.578908949114, 9371.109744574254, 9505.42967421957, 9848.65529706464, 10023.649172278936, 1815.9636807263912, 1852.8147185281498, 1933.9129739161772, 1937.8062193780509, 1958.177565422526, 77728.22271777266, 78285.60857195678, 80518.5974070126, 80977.19022809755, 82206.58896705537, 10092.394456332497, 10113.848292275621, 10279.640212592523, 10477.10944569705, 10628.096611788085, 14090.929545352208, 14092.295385230698, 14098.154110753389, 14102.083364581269, 14153.221572813389, 6940.548864323803, 7339.412846972229, 7360.595167265745, 7525.698972041167, 7576.924230757732, 6676.6661666917435, 6743.123393958852, 6785.626790526469, 7202.099737532809, 7219.783406497813, 4299.247631664446, 4367.10474352757, 4410.867673969786, 4479.955200448019, 4483.775811209426, 1802.2160360243336, 1808.3941879470262, 1845.7323688065155, 1871.709884967832, 1879.4173806119873, 912.1471424218377, 914.1498406482035, 959.8212058627017, 967.7338731848798, 967.7967626798311, 18146.81853181451, 18748.250069997048, 18952.0, 19153.808461915203, 19502.90248548748, 922.9907700923039, 960.3229723045237, 979.8187335342984, 991.177322822056, 994.6319861651235, 10244.385336879812, 10609.628662996913, 10826.458677066115, 10846.891531084746, 10850.29473084247, 427432.0, 435641.0, 443040.0, 443659.0, 446406.0, 85873.0, 87830.56084719536, 87842.56078719694, 88285.0, 88357.0, 927.2257664849791, 949.2595775295281, 963.5471328475605, 969.7527130581657, 969.9321047526746, 16210.756838647194, 16703.665926681155, 17010.724195685125, 17121.887077339932, 17336.65326693484, 41205.0, 41747.7912610435, 41913.0, 42954.78522607367, 43183.78408107939, 55136.44863551313, 56132.43867561272, 56464.717676411354, 56582.0, 57760.0, 7946.245106714853, 7999.280064793964, 8049.154838742082, 8075.3135983439715, 8368.0, 12057.819132713192, 12419.37903104823, 12978.351082446028, 13036.087473876738, 13148.0, 10846.620368287073, 10982.0665243452, 11498.195126341076, 11684.591039313584, 11714.062874969812, 11080.5567777288, 11097.33415995043, 11466.885331146581, 11530.654080377602, 12011.177373317438, 11251.662450126509, 11413.372264525531, 11579.073674105883, 11636.825447618123, 11827.70430739204, 8090.514569125871, 8107.959460202661, 8230.711925082833, 8241.581033943745, 8260.463069900437, 10195.23535734808, 10719.785604287714, 10958.780824383308, 11602.6519204424, 11776.88223117792], "value": 8827.041268495357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.7102666386725, 1452.6005348529154, 1453.5639308207537, 1573.5594033670568, 1733.9653206935861, 6797.2523022467485, 7397.556146631199, 7668.808279793001, 7695.038120234971, 7920.445568810185, 7744.4966077204945, 7815.804604884881, 7816.374690024799, 7818.983532140814, 7820.726274580391, 2200.4388880835363, 2211.5687440949023, 2219.833512486562, 2222.69993550871, 2229.765874583162, 2152.0, 2204.415829805103, 2228.5877112734115, 2229.0303717882693, 2229.7993180613744, 2201.1305534313938, 2206.8013878750908, 2229.877356745378, 2232.229880691159, 2245.202952951703, 2170.522485053286, 2186.4424571734266, 2204.8566843155145, 2208.7791220877866, 2210.812080973119, 2123.532822778986, 2144.946376340604, 2180.1715348167754, 2183.1267493002765, 2183.9344819655275, 7389.556626602421, 7438.516496427769, 7439.739609113709, 7447.85104297911, 7452.5901075440825, 4517.232070548015, 4558.8860278492975, 4629.930551041737, 4630.930536041962, 4680.578747912704, 2964.2589352661835, 3080.645725741546, 3136.560881476595, 3167.4298626247264, 3171.6511183769767, 1021.7088129883022, 1036.1296510930854, 1069.096613361708, 1070.769784496337, 1094.124700239805, 10552.894471055268, 10633.893661063368, 10677.626283080133, 10732.195085368628, 10736.946315268373, 3971.7418367806, 4119.7940102994735, 4174.248635245685, 4201.390798334224, 4201.68487363449, 8552.10202928696, 8556.57217139153, 8559.358048146414, 8561.14388561139, 8564.74305770828, 4773.1408346497965, 4777.355057067321, 4779.976100119477, 4781.832635857798, 4783.354247176656, 3729.3590820039094, 3974.0859602291634, 4113.9794301028305, 4335.067960388532, 4425.09285596452, 3235.320582677664, 3547.166415892263, 3557.48416479609, 3565.607783143852, 3580.7314451415727, 1022.8261195596766, 1059.6715018344337, 1070.7537266428765, 1075.0595175707765, 1080.0441609175937, 845.6744153500823, 877.9692710755093, 891.826093911681, 929.0987741890356, 938.2400255792829, 4935.582653525075, 5107.795688172506, 5376.946230537723, 5417.729113544386, 5453.781848726086, 919.6827094652334, 921.7280902133887, 930.0978051290238, 946.1437399153776, 968.2205824311496, 3558.1460449491938, 3559.4660800880074, 3575.213453040327, 3601.099725068733, 3640.8543658253902, 9127.0, 9467.147956683932, 9468.479233642078, 9485.620575177054, 9584.616615335308, 9470.431774093577, 9474.242060635133, 9486.098820612031, 9498.050194980447, 9501.667441639509, 7247.405570774421, 7398.297161769623, 7407.037085178892, 7408.481406301507, 7412.332890039922, 4867.41591009067, 5039.3448851649055, 5055.241713742968, 5056.241563765465, 5271.973640131775, 8490.363222758442, 8565.700200492953, 8575.271101956403, 8640.611172497127, 8657.437266577652, 7849.843003139791, 8313.667453302041, 8657.0, 8754.737357879274, 8776.385653004229, 6054.848628784315, 6625.238097618835, 6729.394354508117, 6819.89770153458, 6949.861002780017, 7607.581583012766, 7609.543427394374, 7658.540487570764, 7667.846643066996, 7747.92252077472, 6923.515353925177, 6940.514164008471, 6942.0, 6971.3028697129885, 6977.0, 6686.899696504459, 6800.965995169992, 6806.319368063154, 6808.217055038734, 6845.452363810784, 6284.560080794484, 6389.840253993687, 6390.936090639034, 6391.4247717703765, 6399.6800159992745, 4369.7159684621665, 4506.909861802811, 4539.546045395434, 4572.1312950539295, 4690.577847993697, 4578.175928332932, 4580.106879158532, 4656.161890859677, 4724.48030716614, 4904.5340692634145], "value": 4148.562887897287, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.5124045325212, 302.6897430134112, 310.5915720827112, 313.9340738444927, 318.33309217189986, 5041.269015992679, 5178.792848286073, 5198.220266959953, 5236.607254455912, 5246.291750613671, 5020.523050310224, 5115.7697903594335, 5157.252198431225, 5169.0, 5185.377754669445, 4047.494063242095, 4073.6537394321517, 4073.87778366648, 4076.6331030207202, 4082.2243773682903, 3903.3169195390833, 4061.1877624475073, 4066.573009833969, 4068.3897415387783, 4086.5504794472586, 4040.3939409088725, 4041.4139949707273, 4048.2915489789316, 4050.160058729819, 4053.7770422626745, 4026.617471340218, 4032.45561849151, 4033.6369726724733, 4039.878803635881, 4047.2310261050307, 3562.7149828013958, 3588.515550400715, 3598.2803439312243, 3601.207734298476, 3605.7836529808033, 4789.616830653575, 5038.874028149289, 5054.342935418372, 5055.317532133152, 5065.493450654905, 4576.931346029779, 4577.359169716243, 4580.587747102743, 4584.601696482571, 4592.655550833668, 5420.910081253687, 5423.538999185074, 5425.755840987165, 5436.592255580807, 5436.728163591844, 3662.322470342995, 3844.903877403059, 3856.4408160816806, 3873.341531939577, 3882.8252728627, 5594.776208951637, 5612.15817627355, 5615.66306021636, 5616.747246373923, 5626.859328516779, 3882.3011857865854, 3897.7271590988926, 3909.843606255775, 3930.6069393060466, 3933.2920074386884, 3868.1490072184074, 3926.784026878549, 3937.2716047530726, 3973.5231772186944, 3976.1848820991627, 4526.660500462479, 4537.886552836206, 4547.909041819145, 4549.7042692224895, 4552.339910712928, 5350.652207606571, 5383.327084114486, 5385.7576409061685, 5398.6220964532895, 5401.0, 1305.9151155174884, 1326.7678156322604, 1343.7581235377531, 1343.8521762606106, 1348.1506650809927, 918.5131880103556, 935.4480856294683, 937.7983733497331, 940.1820416237916, 943.8772959515356, 5160.297101956346, 5176.670498275791, 5186.392218412304, 5187.584993200535, 5225.634205605571, 5293.570735901362, 5502.779888804403, 5510.669359838423, 5514.862128446821, 5523.309586301712, 5202.375714914158, 5226.484319547365, 5230.326295585376, 5232.2413250078525, 5232.3459567554055, 2573.597389422769, 2577.329894227477, 2579.8065145113815, 2590.080521414908, 2599.415131595376, 5042.773075211624, 5426.565874730012, 5763.7982670606325, 5782.913256301159, 5830.0, 5653.604247702621, 5666.829995100154, 5712.80005199816, 5717.599768016282, 5748.396418376094, 5653.925754106789, 5748.971255143698, 5750.166225897305, 5831.0, 5850.414958504116, 5529.511719726059, 5552.416996215339, 5574.108142697149, 5578.246936663499, 5588.357338905916, 5523.392426833126, 5531.1426728857095, 5535.723213839373, 5570.916436253378, 5587.413321601173, 5658.350364015269, 5752.597318187687, 5785.0454674978155, 5792.333881603669, 5823.126531020381, 3968.265870813909, 4007.779572123561, 4015.9598404015587, 4016.2770701274053, 4020.979895100506, 5490.258815060076, 5493.505584497414, 5510.366307874646, 5520.585956053232, 5534.695591742493, 5227.778194267497, 5416.322959630046, 5437.26596909428, 5502.284702988586, 5519.503244707996, 5216.9739151304, 5446.782128714807, 5473.0, 5490.862728431821, 5507.173923911445, 5249.477651481027, 5328.108521474821, 5361.51746342831, 5382.623216374816, 5395.56835453155, 5403.270558474555, 5407.432219617041, 5451.1466101525675, 5457.372402173642, 5469.097598896296, 5146.716930568855, 5322.707251101227, 5341.4925582069645, 5354.3574771027725, 5359.0], "value": 4108.742924114147, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.2276543777192, 752.6048824367207, 777.5089846588818, 803.1286054630725, 871.1288711288713, 14226.0, 15085.170315632637, 15296.464623738171, 15500.147491887941, 15602.453914113008, 13704.657383565416, 14023.158610483353, 14043.157410555348, 14051.929740351285, 14067.366968486416, 663.4228221447347, 799.9360051195905, 810.7770363150122, 811.37524106438, 811.6915572082601, 677.9593224406527, 798.656577671601, 809.4778867630375, 815.5555222403805, 817.1828171828172, 850.3537311643134, 852.9488230706178, 853.2875049333783, 853.3855623950745, 853.4495250563383, 686.1046334533432, 847.1697736218509, 850.7320194138888, 850.7617866997219, 851.3359579527947, 513.4711247415169, 604.3956043956044, 617.1575799034331, 619.2074145094286, 621.6891554222889, 13895.79156312656, 13898.444062237499, 13924.234167120805, 13927.512537061255, 13933.512327068605, 12150.45322960469, 12366.75266494674, 12487.0, 12692.428840702098, 12708.618741437771, 11971.94014029933, 11992.0, 12158.878411215863, 12240.265584064895, 12608.11743177978, 4276.358546218061, 4287.571242875719, 4307.073979094478, 4536.841210557614, 4547.090581883604, 60843.0, 61452.0, 61856.99999999955, 61902.0, 63005.36994630041, 9911.207103431709, 9924.950375248078, 9952.751181220383, 10017.69946901594, 10159.644412445528, 17891.01599412019, 17922.19350129221, 17939.641207175784, 17948.910255448638, 17964.371247006555, 7613.695452181962, 7714.845703086019, 7775.455718099792, 7830.2952734254195, 7998.320142787812, 4389.0, 4413.360062790877, 4436.467623885154, 4470.932936005963, 4483.50681425043, 3064.509678451437, 3087.371110956464, 3087.969120308813, 3088.3977624363483, 3090.3510262844607, 518.4219595151454, 518.6343627742433, 521.499360613815, 529.6477842234871, 534.1240365800091, 608.3794529579803, 646.7380710812129, 672.7208208593379, 680.6732768271158, 720.8486217894301, 8253.546054967035, 8273.420860539825, 8573.485590864568, 8598.78503037429, 8962.82074358509, 553.4852587094041, 584.8216294030276, 587.6709042935884, 602.0050250006271, 673.2056173714965, 3993.7803420812133, 4077.895726622633, 4165.58344165581, 4278.294081476583, 4345.9130817383475, 76530.0, 81259.59370203229, 81306.78039829407, 82554.0, 84047.0, 66575.0, 68267.0, 68414.31585684179, 70129.2987070133, 73340.0, 62351.0, 65250.0, 65605.67197163984, 65840.0, 65922.67038664872, 8032.437729358889, 8175.223353781381, 8227.0, 8380.20388063133, 8381.980833217296, 45311.77344113258, 45628.54371456243, 46153.76923115363, 46532.7673361631, 46922.765386172854, 56146.43853561412, 60679.0, 61654.38345616486, 62174.0, 63173.0, 10172.440515771703, 10326.586936522455, 10330.276880618285, 10416.895831041593, 10515.474226288501, 12034.338111403957, 12317.137800353888, 12342.259464431803, 12405.379731013594, 12709.872901270868, 13002.154859934075, 13050.804237936249, 13377.464901403835, 13727.725445491234, 14187.716245675236, 12523.49906003786, 13012.739745205232, 13194.142380745221, 13691.589252322447, 14072.296385180905, 11966.999305406434, 12328.630141095782, 12490.795103990158, 12513.499460021862, 12627.179233349803, 10683.412412317397, 10724.946375268073, 10800.981180714192, 11076.335419874833, 11295.604653837405, 9849.556769945226, 11249.268797528463, 11332.206745527734, 11529.711757206136, 11533.769324613628], "value": 6816.410729854455, "unit": "score"}], "name": "dromaeo_css", "value": 6885.657749491945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 112.0, 112.0, 114.0, 113.0, 112.0, 114.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 128.0, 130.0, 169.0, 125.0, 126.0, 121.0, 123.0, 158.0, 128.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 160.0, 161.0, 161.0, 161.0, 162.0, 160.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 106.0, 76.0, 77.0, 76.0, 75.0, 98.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 110.0, 82.0, 82.0, 81.0, 111.0, 83.0, 83.0, 122.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 119.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 144.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 51.0, 52.0, 53.0, 52.0, 59.0, 52.0, 53.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 60.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 82.0, 79.0, 92.0, 78.0, 80.0, 79.0, 80.0, 80.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 139.0, 138.0, 139.0, 137.0, 132.0, 132.0, 128.0, 173.0, 136.0], "value": 138.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 163.0, 165.0, 162.0, 164.0, 163.0, 174.0, 163.0, 166.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 62.0, 64.0, 64.0, 64.0, 63.0, 64.0, 62.0, 63.0, 63.0], "value": 63.5, "unit": "score"}], "name": "kraken", "value": 1490.2, "alertThreshold": 2.0}]} 08:52:12 INFO - Return code: 0 08:52:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:52:12 INFO - # TBPL SUCCESS # 08:52:12 INFO - Running post-action listener: _resource_record_post_action 08:52:12 INFO - [mozharness: 2016-11-03 15:52:12.338627Z] Finished run-tests step (success) 08:52:12 INFO - Running post-run listener: _resource_record_post_run 08:52:12 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392732672; Read time: 0; Write time: 299640 08:52:12 INFO - TinderboxPrint: CPU usage
13.1% 08:52:12 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 0 08:52:12 INFO - TinderboxPrint: I/O write bytes / time
392,732,672 / 299,640 08:52:12 INFO - TinderboxPrint: CPU idle
8,317.2 (86.9%) 08:52:12 INFO - TinderboxPrint: CPU user
1,199.6 (12.5%) 08:52:12 INFO - TinderboxPrint: Swap in / out
0 / 0 08:52:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103440384; Read time: 0; Write time: 87944 08:52:12 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288677888; Read time: 0; Write time: 211696 08:52:12 INFO - Running post-run listener: _upload_blobber_files 08:52:12 INFO - Blob upload gear active. 08:52:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:52:12 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 08:52:12 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'] 08:52:12 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 08:52:13 INFO - (blobuploader) - INFO - Open directory for files ... 08:52:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:52:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:52:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:16 INFO - (blobuploader) - INFO - Done attempting. 08:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:17 INFO - (blobuploader) - INFO - Done attempting. 08:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:52:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:17 INFO - (blobuploader) - INFO - Done attempting. 08:52:17 INFO - (blobuploader) - INFO - Iteration through files over. 08:52:17 INFO - Return code: 0 08:52:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:52:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:52:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ba81912e4f38740ac99e871f12ed715c11d3e59b3e245c07666ca7080ea73d3b3cca2746c4e8a8ccdb813285da5333f859ad739265aaf075443554f99fc59b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbf09dbcd6bb9287f87e93283a5a8e1c52ae55da93fead9aec8d23b6cf53f3c11734c842659207ab81ca34a050cdbb5ff6e51aa6c84024ff50b2e3807e8c155e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3b66bfa24fbfea1d7f679f4cb9b37ccec0a0ff4628ae0de03ee8ac06ccde8ae3648586ddd6e8c5bd20f09ceb6a366314a9fa3b7607c817df219f27ebb43ac06"} 08:52:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:52:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:52:17 INFO - Contents: 08:52:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/4ba81912e4f38740ac99e871f12ed715c11d3e59b3e245c07666ca7080ea73d3b3cca2746c4e8a8ccdb813285da5333f859ad739265aaf075443554f99fc59b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbf09dbcd6bb9287f87e93283a5a8e1c52ae55da93fead9aec8d23b6cf53f3c11734c842659207ab81ca34a050cdbb5ff6e51aa6c84024ff50b2e3807e8c155e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3b66bfa24fbfea1d7f679f4cb9b37ccec0a0ff4628ae0de03ee8ac06ccde8ae3648586ddd6e8c5bd20f09ceb6a366314a9fa3b7607c817df219f27ebb43ac06"} 08:52:17 INFO - Running post-run listener: copy_logs_to_upload_dir 08:52:17 INFO - Copying logs to upload dir... 08:52:17 INFO - mkdir: /builds/slave/test/build/upload/logs 08:52:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.896685 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-03 08:52:17.854733) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 08:52:17.858702) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017 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/4ba81912e4f38740ac99e871f12ed715c11d3e59b3e245c07666ca7080ea73d3b3cca2746c4e8a8ccdb813285da5333f859ad739265aaf075443554f99fc59b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbf09dbcd6bb9287f87e93283a5a8e1c52ae55da93fead9aec8d23b6cf53f3c11734c842659207ab81ca34a050cdbb5ff6e51aa6c84024ff50b2e3807e8c155e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3b66bfa24fbfea1d7f679f4cb9b37ccec0a0ff4628ae0de03ee8ac06ccde8ae3648586ddd6e8c5bd20f09ceb6a366314a9fa3b7607c817df219f27ebb43ac06"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011317 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478091748/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/4ba81912e4f38740ac99e871f12ed715c11d3e59b3e245c07666ca7080ea73d3b3cca2746c4e8a8ccdb813285da5333f859ad739265aaf075443554f99fc59b6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fbf09dbcd6bb9287f87e93283a5a8e1c52ae55da93fead9aec8d23b6cf53f3c11734c842659207ab81ca34a050cdbb5ff6e51aa6c84024ff50b2e3807e8c155e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3b66bfa24fbfea1d7f679f4cb9b37ccec0a0ff4628ae0de03ee8ac06ccde8ae3648586ddd6e8c5bd20f09ceb6a366314a9fa3b7607c817df219f27ebb43ac06"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 08:52:17.884440) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 08:52:17.884778) ========= 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=03627c79f6bb3d1578c4a402000001ba-1478187096.847674-190731017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 08:52:17.967388) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 08:52:17.967719) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 08:52:17.968028) ========= ========= Total master_lag: 0.18 =========