builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-008 starttime: 1475652359.51 results: success (0) buildid: 20161004213011 builduid: 496790168fe742f79156f88aceb91a4d revision: 4f0c0926419e351e0fda8a78cd92199d9cbee810 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.513286) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.513795) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.514162) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.596599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.596923) ========= 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=32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-05 00:25:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.9M=0s 2016-10-05 00:25:59 (24.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131011 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.756682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.757043) ========= 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=32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019398 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.811604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:25:59.812264) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4f0c0926419e351e0fda8a78cd92199d9cbee810 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4f0c0926419e351e0fda8a78cd92199d9cbee810 --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=32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-05 00:25:59,844 truncating revision to first 12 chars 2016-10-05 00:25:59,845 Setting DEBUG logging. 2016-10-05 00:25:59,845 attempt 1/10 2016-10-05 00:25:59,845 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4f0c0926419e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-05 00:26:00,157 unpacking tar archive at: autoland-4f0c0926419e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.693854 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:26:00.519456) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 00:26:00.519754) ========= script_repo_revision: 4f0c0926419e351e0fda8a78cd92199d9cbee810 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-05 00:26:00.520232) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 00:26:00.520501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-05 00:26:00.537911) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-05 00:26:00.538249) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:26:00 INFO - MultiFileLogger online at 20161005 00:26:00 in /builds/slave/test 00:26:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 00:26:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:26:00 INFO - {'append_to_log': False, 00:26:00 INFO - 'base_work_dir': '/builds/slave/test', 00:26:00 INFO - 'blob_upload_branch': 'Autoland', 00:26:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:26:00 INFO - 'branch': 'Autoland', 00:26:00 INFO - 'buildbot_json_path': 'buildprops.json', 00:26:00 INFO - 'config_files': ('talos/linux_config.py',), 00:26:00 INFO - 'default_actions': ('clobber', 00:26:00 INFO - 'read-buildbot-config', 00:26:00 INFO - 'download-and-extract', 00:26:00 INFO - 'populate-webroot', 00:26:00 INFO - 'create-virtualenv', 00:26:00 INFO - 'install', 00:26:00 INFO - 'run-tests'), 00:26:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:26:00 INFO - 'download_minidump_stackwalk': True, 00:26:00 INFO - 'download_symbols': 'ondemand', 00:26:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:26:00 INFO - 'tooltool.py': '/tools/tooltool.py', 00:26:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:26:00 INFO - '/tools/misc-python/virtualenv.py')}, 00:26:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:26:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:26:00 INFO - 'installer_path': 'installer.exe', 00:26:00 INFO - 'log_level': 'info', 00:26:00 INFO - 'log_name': 'talos', 00:26:00 INFO - 'log_to_console': True, 00:26:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:26:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:26:00 INFO - 'opt_config_files': (), 00:26:00 INFO - 'pip_index': False, 00:26:00 INFO - 'sps_profile': False, 00:26:00 INFO - 'sps_profile_interval': 0, 00:26:00 INFO - 'suite': 'dromaeojs', 00:26:00 INFO - 'system_bits': '32', 00:26:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:26:00 INFO - 'title': 'talos-linux64-ix-008', 00:26:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:26:00 INFO - 'use_talos_json': True, 00:26:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:26:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:26:00 INFO - 'work_dir': 'build'} 00:26:00 INFO - [mozharness: 2016-10-05 07:26:00.764182Z] Running clobber step. 00:26:00 INFO - Running pre-action listener: _resource_record_pre_action 00:26:00 INFO - Running main action method: clobber 00:26:00 INFO - rmtree: /builds/slave/test/build 00:26:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:26:01 INFO - Running post-action listener: _resource_record_post_action 00:26:01 INFO - [mozharness: 2016-10-05 07:26:01.175026Z] Finished clobber step (success) 00:26:01 INFO - [mozharness: 2016-10-05 07:26:01.175126Z] Running read-buildbot-config step. 00:26:01 INFO - Running pre-action listener: _resource_record_pre_action 00:26:01 INFO - Running main action method: read_buildbot_config 00:26:01 INFO - Using buildbot properties: 00:26:01 INFO - { 00:26:01 INFO - "project": "", 00:26:01 INFO - "product": "firefox", 00:26:01 INFO - "script_repo_revision": "production", 00:26:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:26:01 INFO - "repository": "", 00:26:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 00:26:01 INFO - "buildid": "20161004213011", 00:26:01 INFO - "pgo_build": "True", 00:26:01 INFO - "basedir": "/builds/slave/test", 00:26:01 INFO - "buildnumber": 315, 00:26:01 INFO - "slavename": "talos-linux64-ix-008", 00:26:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:26:01 INFO - "platform": "ubuntu64_hw", 00:26:01 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 00:26:01 INFO - "branch": "autoland", 00:26:01 INFO - "repo_path": "integration/autoland", 00:26:01 INFO - "revision": "4f0c0926419e351e0fda8a78cd92199d9cbee810", 00:26:01 INFO - "stage_platform": "linux64-pgo", 00:26:01 INFO - "builduid": "496790168fe742f79156f88aceb91a4d", 00:26:01 INFO - "slavebuilddir": "test" 00:26:01 INFO - } 00:26:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:26:01 INFO - Running post-action listener: _resource_record_post_action 00:26:01 INFO - [mozharness: 2016-10-05 07:26:01.177561Z] Finished read-buildbot-config step (success) 00:26:01 INFO - [mozharness: 2016-10-05 07:26:01.177649Z] Running download-and-extract step. 00:26:01 INFO - Running pre-action listener: _resource_record_pre_action 00:26:01 INFO - Running main action method: download_and_extract 00:26:01 INFO - mkdir: /builds/slave/test/build/tests 00:26: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')]} 00:26:01 INFO - trying https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:26:01 INFO - Downloading https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/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 00:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/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 00:26:01 INFO - Downloaded 1361 bytes. 00:26:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:26:01 INFO - Using the following test package requirements: 00:26:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:26:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:26:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'jsshell-linux-x86_64.zip'], 00:26:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:26:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:26:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:26:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:26:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:26:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:26:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:26:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:26:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:26:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:26:01 INFO - Fetch https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:26:02 INFO - Http code: 200 00:26:02 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 00:26:02 INFO - x-amz-cf-id: ubgwjhu3Bqv7K1le5Yy2mdse44apVUetxai4wu6qyvPEs-MpeVFC1A== 00:26:02 INFO - x-amz-version-id: fZUvRAdl_6gi.rkzvuIX.970voDLUJ9J 00:26:02 INFO - Expected file size: 21992457 00:26:02 INFO - Obtained file size: 21992457 00:26:06 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 00:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:26:06 INFO - Fetch https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:26:07 INFO - Http code: 200 00:26:07 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 00:26:07 INFO - x-amz-cf-id: Eb497SyDGbQg3y_CywF7StyZkhV97O2w7mX4NsDKJvc8W1MQzoc_Gg== 00:26:07 INFO - x-amz-version-id: fZUvRAdl_6gi.rkzvuIX.970voDLUJ9J 00:26:07 INFO - Expected file size: 21992457 00:26:07 INFO - Obtained file size: 21992457 00:26:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:26:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:26:12 INFO - Fetch https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:26:12 INFO - Http code: 200 00:26:12 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 00:26:12 INFO - x-amz-cf-id: EeA1Ys84OyOT7AuctJ75RX6OZaWQDAVPqPoIID_YG3TJpmlzkil6vQ== 00:26:12 INFO - x-amz-version-id: Wh4lDXufPY6awJBE_j5TNxepDr8er5hH 00:26:13 INFO - Expected file size: 14409006 00:26:13 INFO - Obtained file size: 14409006 00:26:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:13 INFO - trying https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:26:13 INFO - Downloading https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/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 00:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/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 00:26:15 INFO - Downloaded 59696627 bytes. 00:26:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:26:15 INFO - mkdir: /builds/slave/test/properties 00:26:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:26:15 INFO - Writing to file /builds/slave/test/properties/build_url 00:26:15 INFO - Contents: 00:26:15 INFO - build_url:https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:26:16 INFO - Running post-action listener: _resource_record_post_action 00:26:16 INFO - Running post-action listener: set_extra_try_arguments 00:26:16 INFO - [mozharness: 2016-10-05 07:26:16.309154Z] Finished download-and-extract step (success) 00:26:16 INFO - [mozharness: 2016-10-05 07:26:16.309421Z] Running populate-webroot step. 00:26:16 INFO - Running pre-action listener: _resource_record_pre_action 00:26:16 INFO - Running main action method: populate_webroot 00:26:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:26:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:26:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:26:16 INFO - '--tppagecycles', 00:26:16 INFO - '7'], 00:26:16 INFO - 'tests': ['tsvgm']}}, 00:26:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:26:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:26:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:26:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:26:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:26:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['damp', 'tps']}, 00:26:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'tests': ['damp', 'tps']}, 00:26:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['dromaeo_dom']}, 00:26:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:26:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['basic_compositor_video']}, 00:26:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:26:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['a11yr', 00:26:16 INFO - 'ts_paint', 00:26:16 INFO - 'tpaint', 00:26:16 INFO - 'sessionrestore', 00:26:16 INFO - 'sessionrestore_no_auto_restore', 00:26:16 INFO - 'tabpaint']}, 00:26:16 INFO - 'other-e10s': {'tests': ['a11yr', 00:26:16 INFO - 'ts_paint', 00:26:16 INFO - 'tpaint', 00:26:16 INFO - 'sessionrestore', 00:26:16 INFO - 'sessionrestore_no_auto_restore', 00:26:16 INFO - 'tabpaint']}, 00:26:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:26:16 INFO - 'ts_paint', 00:26:16 INFO - 'tpaint', 00:26:16 INFO - 'sessionrestore', 00:26:16 INFO - 'sessionrestore_no_auto_restore', 00:26:16 INFO - 'tabpaint']}, 00:26:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:26:16 INFO - 'ts_paint', 00:26:16 INFO - 'tpaint', 00:26:16 INFO - 'sessionrestore', 00:26:16 INFO - 'sessionrestore_no_auto_restore', 00:26:16 INFO - 'tabpaint']}, 00:26:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['a11yr', 00:26:16 INFO - 'ts_paint', 00:26:16 INFO - 'tpaint', 00:26:16 INFO - 'sessionrestore', 00:26:16 INFO - 'sessionrestore_no_auto_restore', 00:26:16 INFO - 'tabpaint']}, 00:26:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['a11yr', 00:26:16 INFO - 'ts_paint', 00:26:16 INFO - 'tpaint', 00:26:16 INFO - 'sessionrestore', 00:26:16 INFO - 'sessionrestore_no_auto_restore', 00:26:16 INFO - 'tabpaint']}, 00:26:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['tsvgx', 00:26:16 INFO - 'tsvgr_opacity', 00:26:16 INFO - 'tart', 00:26:16 INFO - 'tscrollx', 00:26:16 INFO - 'cart']}, 00:26:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:26:16 INFO - 'tsvgr_opacity', 00:26:16 INFO - 'tart', 00:26:16 INFO - 'tscrollx', 00:26:16 INFO - 'cart']}, 00:26:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'talos_options': ['--disable-e10s'], 00:26:16 INFO - 'tests': ['tp5o']}, 00:26:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'tests': ['tp5o']}, 00:26:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'talos_options': ['--disable-e10s', 00:26:16 INFO - '--xperf_path', 00:26:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:16 INFO - 'tests': ['tp5n']}, 00:26:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:26:16 INFO - 'talos_options': ['--xperf_path', 00:26:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:26:16 INFO - 'tests': ['tp5n']}}, 00:26:16 INFO - 'talos.zip': {'path': '', 00:26:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:26:16 INFO - Running post-action listener: _resource_record_post_action 00:26:16 INFO - [mozharness: 2016-10-05 07:26:16.325228Z] Finished populate-webroot step (success) 00:26:16 INFO - [mozharness: 2016-10-05 07:26:16.325322Z] Running create-virtualenv step. 00:26:16 INFO - Running pre-action listener: _resource_record_pre_action 00:26:16 INFO - Running main action method: create_virtualenv 00:26:16 INFO - Creating virtualenv /builds/slave/test/build/venv 00:26:16 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 00:26:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:26:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:26:16 INFO - Using real prefix '/usr' 00:26:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:26:17 INFO - Installing distribute.............................................................................................................................................................................................done. 00:26:19 INFO - Installing pip.................done. 00:26:19 INFO - Return code: 0 00:26:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:26:19 INFO - Reading from file tmpfile_stdout 00:26:19 INFO - Output received: 00:26:19 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) 00:26:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:26:19 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')]} 00:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:19 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')]} 00:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:19 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:19 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 00:26:19 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 00:26:19 INFO - Using env: {'DISPLAY': ':0', 00:26:19 INFO - 'HOME': '/home/cltbld', 00:26:19 INFO - 'LANG': 'en_US.UTF-8', 00:26:19 INFO - 'LANGUAGE': 'en_US:en', 00:26:19 INFO - 'LOGNAME': 'cltbld', 00:26:19 INFO - 'MAIL': '/var/mail/cltbld', 00:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:19 INFO - 'MOZ_NO_REMOTE': '1', 00:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:19 INFO - 'NO_EM_RESTART': '1', 00:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:19 INFO - 'PWD': '/builds/slave/test', 00:26:19 INFO - 'SHELL': '/bin/bash', 00:26:19 INFO - 'SHLVL': '1', 00:26:19 INFO - 'TERM': 'linux', 00:26:19 INFO - 'TMOUT': '86400', 00:26:19 INFO - 'USER': 'cltbld', 00:26:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:19 INFO - '_': '/tools/buildbot/bin/python'} 00:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:19 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 00:26:19 INFO - Cleaning up... 00:26:19 INFO - Return code: 0 00:26:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:26:19 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')]} 00:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:19 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')]} 00:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:19 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:19 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 00:26:19 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 00:26:19 INFO - Using env: {'DISPLAY': ':0', 00:26:19 INFO - 'HOME': '/home/cltbld', 00:26:19 INFO - 'LANG': 'en_US.UTF-8', 00:26:19 INFO - 'LANGUAGE': 'en_US:en', 00:26:19 INFO - 'LOGNAME': 'cltbld', 00:26:19 INFO - 'MAIL': '/var/mail/cltbld', 00:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:19 INFO - 'MOZ_NO_REMOTE': '1', 00:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:19 INFO - 'NO_EM_RESTART': '1', 00:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:19 INFO - 'PWD': '/builds/slave/test', 00:26:19 INFO - 'SHELL': '/bin/bash', 00:26:19 INFO - 'SHLVL': '1', 00:26:19 INFO - 'TERM': 'linux', 00:26:19 INFO - 'TMOUT': '86400', 00:26:19 INFO - 'USER': 'cltbld', 00:26:19 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:19 INFO - '_': '/tools/buildbot/bin/python'} 00:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:19 INFO - Downloading/unpacking psutil>=3.1.1 00:26:19 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 00:26:19 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 00:26:19 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 00:26:19 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 00:26:19 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 00:26:19 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 00:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:26:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:21 INFO - Installing collected packages: psutil 00:26:21 INFO - Running setup.py install for psutil 00:26:22 INFO - building 'psutil._psutil_linux' extension 00:26:22 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 00:26:23 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 00:26:23 INFO - building 'psutil._psutil_posix' extension 00:26:23 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 00:26:23 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 00:26:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:26:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:26:23 INFO - Successfully installed psutil 00:26:23 INFO - Cleaning up... 00:26:23 INFO - Return code: 0 00:26:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:26:23 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')]} 00:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:23 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')]} 00:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:23 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:23 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 00:26:23 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 00:26:23 INFO - Using env: {'DISPLAY': ':0', 00:26:23 INFO - 'HOME': '/home/cltbld', 00:26:23 INFO - 'LANG': 'en_US.UTF-8', 00:26:23 INFO - 'LANGUAGE': 'en_US:en', 00:26:23 INFO - 'LOGNAME': 'cltbld', 00:26:23 INFO - 'MAIL': '/var/mail/cltbld', 00:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:23 INFO - 'MOZ_NO_REMOTE': '1', 00:26:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:23 INFO - 'NO_EM_RESTART': '1', 00:26:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:23 INFO - 'PWD': '/builds/slave/test', 00:26:23 INFO - 'SHELL': '/bin/bash', 00:26:23 INFO - 'SHLVL': '1', 00:26:23 INFO - 'TERM': 'linux', 00:26:23 INFO - 'TMOUT': '86400', 00:26:23 INFO - 'USER': 'cltbld', 00:26:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:23 INFO - '_': '/tools/buildbot/bin/python'} 00:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:26:23 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 00:26:23 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 00:26:23 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 00:26:23 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 00:26:23 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 00:26:23 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 00:26:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:26:25 INFO - Installing collected packages: mozsystemmonitor 00:26:25 INFO - Running setup.py install for mozsystemmonitor 00:26:25 INFO - Successfully installed mozsystemmonitor 00:26:25 INFO - Cleaning up... 00:26:25 INFO - Return code: 0 00:26:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:26:25 INFO - Using env: {'DISPLAY': ':0', 00:26:25 INFO - 'HOME': '/home/cltbld', 00:26:25 INFO - 'LANG': 'en_US.UTF-8', 00:26:25 INFO - 'LANGUAGE': 'en_US:en', 00:26:25 INFO - 'LOGNAME': 'cltbld', 00:26:25 INFO - 'MAIL': '/var/mail/cltbld', 00:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:25 INFO - 'MOZ_NO_REMOTE': '1', 00:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:25 INFO - 'NO_EM_RESTART': '1', 00:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:25 INFO - 'PWD': '/builds/slave/test', 00:26:25 INFO - 'SHELL': '/bin/bash', 00:26:25 INFO - 'SHLVL': '1', 00:26:25 INFO - 'TERM': 'linux', 00:26:25 INFO - 'TMOUT': '86400', 00:26:25 INFO - 'USER': 'cltbld', 00:26:25 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:25 INFO - '_': '/tools/buildbot/bin/python'} 00:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:25 INFO - Downloading/unpacking jsonschema==2.5.1 00:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:26:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:28 INFO - Downloading functools32-3.2.3-2.tar.gz 00:26:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:26:28 INFO - warning: no files found matching '*.txt' 00:26:28 INFO - no previously-included directories found matching 'build' 00:26:28 INFO - no previously-included directories found matching 'dist' 00:26:28 INFO - no previously-included directories found matching '.git*' 00:26:28 INFO - Installing collected packages: jsonschema, functools32 00:26:28 INFO - Running setup.py install for functools32 00:26:28 INFO - warning: no files found matching '*.txt' 00:26:28 INFO - no previously-included directories found matching 'build' 00:26:28 INFO - no previously-included directories found matching 'dist' 00:26:28 INFO - no previously-included directories found matching '.git*' 00:26:28 INFO - Successfully installed jsonschema functools32 00:26:28 INFO - Cleaning up... 00:26:28 INFO - Return code: 0 00:26:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:26:28 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')]} 00:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:28 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')]} 00:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:28 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:28 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 00:26:28 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 00:26:28 INFO - Using env: {'DISPLAY': ':0', 00:26:28 INFO - 'HOME': '/home/cltbld', 00:26:28 INFO - 'LANG': 'en_US.UTF-8', 00:26:28 INFO - 'LANGUAGE': 'en_US:en', 00:26:28 INFO - 'LOGNAME': 'cltbld', 00:26:28 INFO - 'MAIL': '/var/mail/cltbld', 00:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:28 INFO - 'MOZ_NO_REMOTE': '1', 00:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:28 INFO - 'NO_EM_RESTART': '1', 00:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:28 INFO - 'PWD': '/builds/slave/test', 00:26:28 INFO - 'SHELL': '/bin/bash', 00:26:28 INFO - 'SHLVL': '1', 00:26:28 INFO - 'TERM': 'linux', 00:26:28 INFO - 'TMOUT': '86400', 00:26:28 INFO - 'USER': 'cltbld', 00:26:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:28 INFO - '_': '/tools/buildbot/bin/python'} 00:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:26:28 INFO - Cleaning up... 00:26:28 INFO - Return code: 0 00:26:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:26:28 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')]} 00:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:28 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')]} 00:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:28 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:28 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 00:26:28 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 00:26:28 INFO - Using env: {'DISPLAY': ':0', 00:26:28 INFO - 'HOME': '/home/cltbld', 00:26:28 INFO - 'LANG': 'en_US.UTF-8', 00:26:28 INFO - 'LANGUAGE': 'en_US:en', 00:26:28 INFO - 'LOGNAME': 'cltbld', 00:26:28 INFO - 'MAIL': '/var/mail/cltbld', 00:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:28 INFO - 'MOZ_NO_REMOTE': '1', 00:26:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:28 INFO - 'NO_EM_RESTART': '1', 00:26:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:28 INFO - 'PWD': '/builds/slave/test', 00:26:28 INFO - 'SHELL': '/bin/bash', 00:26:28 INFO - 'SHLVL': '1', 00:26:28 INFO - 'TERM': 'linux', 00:26:28 INFO - 'TMOUT': '86400', 00:26:28 INFO - 'USER': 'cltbld', 00:26:28 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:28 INFO - '_': '/tools/buildbot/bin/python'} 00:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:28 INFO - Downloading/unpacking blobuploader==1.2.4 00:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:26:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:26:30 INFO - Downloading blobuploader-1.2.4.tar.gz 00:26:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:26:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:26:30 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 00:26:30 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 00:26:30 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 00:26:30 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 00:26:30 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 00:26:30 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 00:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:26:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 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 00:26:31 INFO - Downloading docopt-0.6.1.tar.gz 00:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:26:31 INFO - Installing collected packages: blobuploader, requests, docopt 00:26:31 INFO - Running setup.py install for blobuploader 00:26:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:26:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:26:31 INFO - Running setup.py install for requests 00:26:31 INFO - Running setup.py install for docopt 00:26:32 INFO - Successfully installed blobuploader requests docopt 00:26:32 INFO - Cleaning up... 00:26:32 INFO - Return code: 0 00:26:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:32 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:32 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 00:26:32 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 00:26:32 INFO - Using env: {'DISPLAY': ':0', 00:26:32 INFO - 'HOME': '/home/cltbld', 00:26:32 INFO - 'LANG': 'en_US.UTF-8', 00:26:32 INFO - 'LANGUAGE': 'en_US:en', 00:26:32 INFO - 'LOGNAME': 'cltbld', 00:26:32 INFO - 'MAIL': '/var/mail/cltbld', 00:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:32 INFO - 'MOZ_NO_REMOTE': '1', 00:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:32 INFO - 'NO_EM_RESTART': '1', 00:26:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:32 INFO - 'PWD': '/builds/slave/test', 00:26:32 INFO - 'SHELL': '/bin/bash', 00:26:32 INFO - 'SHLVL': '1', 00:26:32 INFO - 'TERM': 'linux', 00:26:32 INFO - 'TMOUT': '86400', 00:26:32 INFO - 'USER': 'cltbld', 00:26:32 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:32 INFO - '_': '/tools/buildbot/bin/python'} 00:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:26:32 INFO - Running setup.py (path:/tmp/pip-CSandz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:26:32 INFO - Running setup.py (path:/tmp/pip-Gs8GVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:26:32 INFO - Running setup.py (path:/tmp/pip-4mnnij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:26:32 INFO - Running setup.py (path:/tmp/pip-0zxCIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:26:32 INFO - Running setup.py (path:/tmp/pip-wxjWrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:26:32 INFO - Running setup.py (path:/tmp/pip-yMA8HG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:26:32 INFO - Running setup.py (path:/tmp/pip-ORO4US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:26:32 INFO - Running setup.py (path:/tmp/pip-X6uDbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:26:32 INFO - Running setup.py (path:/tmp/pip-cJDIpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:26:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:26:32 INFO - Running setup.py (path:/tmp/pip-aTvp10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:26:33 INFO - Running setup.py (path:/tmp/pip-mlnUup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:26:33 INFO - Running setup.py (path:/tmp/pip-B4HpsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:26:33 INFO - Running setup.py (path:/tmp/pip-qEfaYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:26:33 INFO - Running setup.py (path:/tmp/pip-nPv4HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:33 INFO - Running setup.py (path:/tmp/pip-rYFHyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:26:33 INFO - Running setup.py (path:/tmp/pip-xol_i3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:26:33 INFO - Running setup.py (path:/tmp/pip-Wes6Wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:26:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:26:33 INFO - Running setup.py install for manifestparser 00:26:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:26:33 INFO - Running setup.py install for mozcrash 00:26:33 INFO - Running setup.py install for mozdebug 00:26:33 INFO - Running setup.py install for mozdevice 00:26:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:26:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:26:33 INFO - Running setup.py install for mozfile 00:26:34 INFO - Running setup.py install for mozhttpd 00:26:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for mozinfo 00:26:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for mozInstall 00:26:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for mozleak 00:26:34 INFO - Running setup.py install for mozlog 00:26:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for moznetwork 00:26:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for mozprocess 00:26:34 INFO - Running setup.py install for mozprofile 00:26:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for mozrunner 00:26:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:26:34 INFO - Running setup.py install for mozscreenshot 00:26:35 INFO - Running setup.py install for moztest 00:26:35 INFO - Running setup.py install for mozversion 00:26:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:26:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:26:35 INFO - Cleaning up... 00:26:35 INFO - Return code: 0 00:26:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:26:35 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')]} 00:26:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:35 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')]} 00:26:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:35 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:35 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 00:26:35 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 00:26:35 INFO - Using env: {'DISPLAY': ':0', 00:26:35 INFO - 'HOME': '/home/cltbld', 00:26:35 INFO - 'LANG': 'en_US.UTF-8', 00:26:35 INFO - 'LANGUAGE': 'en_US:en', 00:26:35 INFO - 'LOGNAME': 'cltbld', 00:26:35 INFO - 'MAIL': '/var/mail/cltbld', 00:26:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:35 INFO - 'MOZ_NO_REMOTE': '1', 00:26:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:35 INFO - 'NO_EM_RESTART': '1', 00:26:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:35 INFO - 'PWD': '/builds/slave/test', 00:26:35 INFO - 'SHELL': '/bin/bash', 00:26:35 INFO - 'SHLVL': '1', 00:26:35 INFO - 'TERM': 'linux', 00:26:35 INFO - 'TMOUT': '86400', 00:26:35 INFO - 'USER': 'cltbld', 00:26:35 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:35 INFO - '_': '/tools/buildbot/bin/python'} 00:26:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:26:35 INFO - Running setup.py (path:/tmp/pip-nYBJm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:26:35 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)) 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:26:35 INFO - Running setup.py (path:/tmp/pip-iFvIvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:26:35 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)) 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:26:35 INFO - Running setup.py (path:/tmp/pip-VGRGJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:26:35 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)) 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:26:35 INFO - Running setup.py (path:/tmp/pip-G3GYlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:26:35 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)) 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:26:35 INFO - Running setup.py (path:/tmp/pip-FNVvip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:26:35 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)) 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:26:35 INFO - Running setup.py (path:/tmp/pip-Y3Nxu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:26:35 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)) 00:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:26:35 INFO - Running setup.py (path:/tmp/pip-ozcSaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:26:36 INFO - Running setup.py (path:/tmp/pip-3TbBsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:26:36 INFO - Running setup.py (path:/tmp/pip-NDSIGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:26:36 INFO - Running setup.py (path:/tmp/pip-8JPoYJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:26:36 INFO - Running setup.py (path:/tmp/pip-H47U4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:26:36 INFO - Running setup.py (path:/tmp/pip-TRImZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:26:36 INFO - Running setup.py (path:/tmp/pip-eBejNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:26:36 INFO - Running setup.py (path:/tmp/pip-4Ve2pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:36 INFO - Running setup.py (path:/tmp/pip-9fFSsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:26:36 INFO - Running setup.py (path:/tmp/pip-LsCvG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:26:36 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)) 00:26:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:26:36 INFO - Running setup.py (path:/tmp/pip-jr_fGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:26:36 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)) 00:26:36 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)) 00:26:36 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)) 00:26:36 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)) 00:26:36 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)) 00:26:36 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)) 00:26:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:26:36 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 00:26:36 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 00:26:36 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 00:26:36 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 00:26:36 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 00:26:36 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 00:26:38 INFO - Downloading blessings-1.6.tar.gz 00:26:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:26:38 INFO - Installing collected packages: blessings 00:26:38 INFO - Running setup.py install for blessings 00:26:38 INFO - Successfully installed blessings 00:26:38 INFO - Cleaning up... 00:26:38 INFO - Return code: 0 00:26:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:26:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:26:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:26:39 INFO - Reading from file tmpfile_stdout 00:26:39 INFO - Current package versions: 00:26:39 INFO - argparse == 1.2.1 00:26:39 INFO - blessings == 1.6 00:26:39 INFO - blobuploader == 1.2.4 00:26:39 INFO - docopt == 0.6.1 00:26:39 INFO - functools32 == 3.2.3-2 00:26:39 INFO - jsonschema == 2.5.1 00:26:39 INFO - manifestparser == 1.1 00:26:39 INFO - mozInstall == 1.12 00:26:39 INFO - mozcrash == 0.17 00:26:39 INFO - mozdebug == 0.1 00:26:39 INFO - mozdevice == 0.48 00:26:39 INFO - mozfile == 1.2 00:26:39 INFO - mozhttpd == 0.7 00:26:39 INFO - mozinfo == 0.9 00:26:39 INFO - mozleak == 0.1 00:26:39 INFO - mozlog == 3.4 00:26:39 INFO - moznetwork == 0.27 00:26:39 INFO - mozprocess == 0.23 00:26:39 INFO - mozprofile == 0.28 00:26:39 INFO - mozrunner == 6.12 00:26:39 INFO - mozscreenshot == 0.1 00:26:39 INFO - mozsystemmonitor == 0.3 00:26:39 INFO - moztest == 0.7 00:26:39 INFO - mozversion == 1.4 00:26:39 INFO - psutil == 3.1.1 00:26:39 INFO - requests == 1.2.3 00:26:39 INFO - wsgiref == 0.1.2 00:26:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:39 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:39 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 00:26:39 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 00:26:39 INFO - Using env: {'DISPLAY': ':0', 00:26:39 INFO - 'HOME': '/home/cltbld', 00:26:39 INFO - 'LANG': 'en_US.UTF-8', 00:26:39 INFO - 'LANGUAGE': 'en_US:en', 00:26:39 INFO - 'LOGNAME': 'cltbld', 00:26:39 INFO - 'MAIL': '/var/mail/cltbld', 00:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:39 INFO - 'MOZ_NO_REMOTE': '1', 00:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:39 INFO - 'NO_EM_RESTART': '1', 00:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:39 INFO - 'PWD': '/builds/slave/test', 00:26:39 INFO - 'SHELL': '/bin/bash', 00:26:39 INFO - 'SHLVL': '1', 00:26:39 INFO - 'TERM': 'linux', 00:26:39 INFO - 'TMOUT': '86400', 00:26:39 INFO - 'USER': 'cltbld', 00:26:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:39 INFO - '_': '/tools/buildbot/bin/python'} 00:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 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)) 00:26:39 INFO - Cleaning up... 00:26:39 INFO - Return code: 0 00:26:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:26:39 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 0x7f9d1683df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x149f790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, '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': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', '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 00:26:39 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 00:26:39 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 00:26:39 INFO - Using env: {'DISPLAY': ':0', 00:26:39 INFO - 'HOME': '/home/cltbld', 00:26:39 INFO - 'LANG': 'en_US.UTF-8', 00:26:39 INFO - 'LANGUAGE': 'en_US:en', 00:26:39 INFO - 'LOGNAME': 'cltbld', 00:26:39 INFO - 'MAIL': '/var/mail/cltbld', 00:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:39 INFO - 'MOZ_NO_REMOTE': '1', 00:26:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:39 INFO - 'NO_EM_RESTART': '1', 00:26:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:39 INFO - 'PWD': '/builds/slave/test', 00:26:39 INFO - 'SHELL': '/bin/bash', 00:26:39 INFO - 'SHLVL': '1', 00:26:39 INFO - 'TERM': 'linux', 00:26:39 INFO - 'TMOUT': '86400', 00:26:39 INFO - 'USER': 'cltbld', 00:26:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:39 INFO - '_': '/tools/buildbot/bin/python'} 00:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:26:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:26:39 INFO - Cleaning up... 00:26:39 INFO - Return code: 0 00:26:39 INFO - Running post-action listener: _resource_record_post_action 00:26:39 INFO - Running post-action listener: _start_resource_monitoring 00:26:39 INFO - Starting resource monitoring. 00:26:39 INFO - [mozharness: 2016-10-05 07:26:39.693604Z] Finished create-virtualenv step (success) 00:26:39 INFO - [mozharness: 2016-10-05 07:26:39.694117Z] Running install step. 00:26:39 INFO - Running pre-action listener: _resource_record_pre_action 00:26:39 INFO - Running main action method: install 00:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:26:39 INFO - Reading from file tmpfile_stdout 00:26:39 INFO - Detecting whether we're running mozinstall >=1.0... 00:26:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:26:39 INFO - Reading from file tmpfile_stdout 00:26:39 INFO - Output received: 00:26:39 INFO - Usage: mozinstall [options] installer 00:26:39 INFO - Options: 00:26:39 INFO - -h, --help show this help message and exit 00:26:39 INFO - -d DEST, --destination=DEST 00:26:39 INFO - Directory to install application into. [default: 00:26:39 INFO - "/builds/slave/test"] 00:26:39 INFO - --app=APP Application being installed. [default: firefox] 00:26:39 INFO - mkdir: /builds/slave/test/build/application 00:26:39 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'] 00:26:39 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 00:26:57 INFO - Reading from file tmpfile_stdout 00:26:57 INFO - Output received: 00:26:57 INFO - /builds/slave/test/build/application/firefox/firefox 00:26:57 INFO - Running post-action listener: _resource_record_post_action 00:26:57 INFO - [mozharness: 2016-10-05 07:26:57.067345Z] Finished install step (success) 00:26:57 INFO - [mozharness: 2016-10-05 07:26:57.067594Z] Running run-tests step. 00:26:57 INFO - Running pre-action listener: _resource_record_pre_action 00:26:57 INFO - Running main action method: run_tests 00:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:26:57 INFO - Python 2.7.3 00:26:57 INFO - Return code: 0 00:26:57 INFO - grabbing minidump binary from tooltool 00:26:57 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')]} 00:26:57 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 0x149c930>, '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 0x149d830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x149dcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:26:57 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 00:26:57 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 00:26:57 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 00:26:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:26:57 INFO - Return code: 0 00:26:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:26:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:26:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:26:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:26:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:26:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 00:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 00:26:57 INFO - Using env: {'DISPLAY': ':0', 00:26:57 INFO - 'HOME': '/home/cltbld', 00:26:57 INFO - 'LANG': 'en_US.UTF-8', 00:26:57 INFO - 'LANGUAGE': 'en_US:en', 00:26:57 INFO - 'LOGNAME': 'cltbld', 00:26:57 INFO - 'MAIL': '/var/mail/cltbld', 00:26:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:26:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:26:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:26:57 INFO - 'MOZ_NO_REMOTE': '1', 00:26:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:26:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:26:57 INFO - 'NO_EM_RESTART': '1', 00:26:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:26:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:26:57 INFO - 'PWD': '/builds/slave/test', 00:26:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:26:57 INFO - 'SHELL': '/bin/bash', 00:26:57 INFO - 'SHLVL': '1', 00:26:57 INFO - 'TERM': 'linux', 00:26:57 INFO - 'TMOUT': '86400', 00:26:57 INFO - 'USER': 'cltbld', 00:26:57 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248', 00:26:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:26:57 INFO - '_': '/tools/buildbot/bin/python'} 00:26:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 00:26:57 INFO - mozversion application_buildid: 20161004213011 00:26:57 INFO - mozversion application_changeset: 4f0c0926419e351e0fda8a78cd92199d9cbee810 00:26:57 INFO - mozversion application_display_name: Nightly 00:26:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:26:57 INFO - mozversion application_name: Firefox 00:26:57 INFO - mozversion application_remotingname: firefox 00:26:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:26:57 INFO - mozversion application_vendor: Mozilla 00:26:57 INFO - mozversion application_version: 52.0a1 00:26:57 INFO - mozversion platform_buildid: 20161004213011 00:26:57 INFO - mozversion platform_changeset: 4f0c0926419e351e0fda8a78cd92199d9cbee810 00:26:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:26:57 INFO - mozversion platform_version: 52.0a1 00:26:57 INFO - using testdate: 1475652417 00:26:57 INFO - actual date: 1475652417 00:26:57 INFO - starting webserver on 'localhost:49554' 00:26:57 INFO - SUITE-START | Running 2 tests 00:26:57 INFO - TEST-START | dromaeo_css 00:26:57 INFO - operating with platform_type : linux_ 00:26:57 INFO - Initialising browser for dromaeo_css test... 00:26:57 INFO - TEST-INFO | started process 3305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeyx9DE/profile http://localhost:49554/getInfo.html) 00:27:03 INFO - PROCESS | 3305 | __metrics Screen width/height:1600/1200 00:27:03 INFO - PROCESS | 3305 | colorDepth:24 00:27:03 INFO - PROCESS | 3305 | Browser inner width/height: 1024/697 00:27:03 INFO - PROCESS | 3305 | __metrics 00:27:04 INFO - PROCESS | 3305 | 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" 00:27:04 INFO - PROCESS | 3305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:27:04 INFO - PROCESS | 3305 | console.error: PushService: 00:27:04 INFO - PROCESS | 3305 | stateChangeProcessEnqueue: Error transitioning state 00:27:04 INFO - PROCESS | 3305 | UnknownError 00:27:05 INFO - TEST-INFO | 3305: exit 0 00:27:05 INFO - Browser initialized. 00:27:05 INFO - Running cycle 1/1 for dromaeo_css test... 00:27:05 INFO - TEST-INFO | started process 3388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeyx9DE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:27:17 INFO - PROCESS | 3388 | RSS: Main: 174387200 00:27:17 INFO - PROCESS | 3388 | 00:28:09 INFO - PROCESS | 3388 | 1475652489599 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] 00:30:19 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:49554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49554/tests/dromaeo/cssquery-ext.html) 00:30:21 INFO - PROCESS | 3388 | RSS: Main: 300044288 00:30:21 INFO - PROCESS | 3388 | 00:33:23 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:49554/tests/dromaeo/cssquery-ext.html (next: http://localhost:49554/tests/dromaeo/cssquery-jquery.html) 00:33:24 INFO - PROCESS | 3388 | RSS: Main: 276619264 00:33:24 INFO - PROCESS | 3388 | 00:36:26 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:49554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49554/tests/dromaeo/cssquery-mootools.html) 00:36:26 INFO - PROCESS | 3388 | RSS: Main: 213430272 00:36:26 INFO - PROCESS | 3388 | 00:39:28 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:49554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49554/tests/dromaeo/cssquery-prototype.html) 00:39:29 INFO - PROCESS | 3388 | RSS: Main: 273043456 00:39:29 INFO - PROCESS | 3388 | 00:42:32 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:49554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49554/tests/dromaeo/cssquery-yui.html) 00:42:32 INFO - PROCESS | 3388 | RSS: Main: 217370624 00:42:32 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | Cycle 1(1): loaded http://localhost:49554/tests/dromaeo/cssquery-yui.html (next: http://localhost:49554/tests/dromaeo/cssquery-dojo.html) 00:45:35 INFO - PROCESS | 3388 | RSS: Main: 301297664 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | __start_tp_report 00:45:35 INFO - PROCESS | 3388 | _x_x_mozilla_page_load 00:45:35 INFO - PROCESS | 3388 | _x_x_mozilla_page_load_details 00:45:35 INFO - PROCESS | 3388 | |i|pagename|runs| 00:45:35 INFO - PROCESS | 3388 | |0;dojo.html;2969.2280007198137;3006.6692663806984;3007;3016.1554764665902;3040.179151629061;5136.33227680402;5195.428502864686;5238.554722848562;5243.659162154458;5285.23364112203;5157.664751791131;5213.348331458567;5226.895462090756;5261.2371206175085;5305.1776974569;4663.044075964436;4698.483166851644;4718.669693121483;4724.5984091352275;4792.017636384533;4868.148074087038;4897.118518666639;4909.779059942293;4927.950720492785;4961.826336078238;4683.1336202802595;4722.03198344342;4732.692374995614;4768.189407800664;4796.736179510125;4718.174319494075;4735.810567577328;4747.905041899177;4753;4769.880752981168;4667.043256132485;4677.064587082563;4682.953170468286;4739.9526004739855;4767.475577686451;5214.582833373321;5219.869503262411;5225.451327610622;5226.694904671761;5274.472552744734;5459.645123066988;5515.172724091378;5567.66594004361;5617.719114044281;5625.971870140664;5626.746796394131;5660.660360378391;5672.8014519492035;5676.290463692038;5683.602147849652;5291.100512912814;5303.655262407931;5306.151015837486;5308.920366194471;5369.865753356119;5484.067708489566;5527.640703354269;5627.803026894039;5689.715514224272;5689.971550142222;5489.972550137224;5490.450954904558;5490.588205884575;5494.148406996922;5553.361363443175;5520.641158324696;5525.475079867406;5531.889362212733;5551.944480555224;5592.692401917933;5414.512693857571;5427.538659214011;5531.474509921551;5575.60970732053;5592.86017849557;5618.494335509742;5619.044762390404;5622.353429355595;5622.971885140548;5682.914756278659;4353.825846966086;4358.084802191575;4358.302671572533;4363.956360436418;4404.53752355998;3822.7897465639103;3824.1395685970433;3826.3877779555696;3857.6528112470014;3863.497745293094;5315.362156541162;5322.28149199853;5322.494363035506;5363.758630861543;5387.164989426645;5615.719214039364;5624.156376543551;5631.7747290108755;5653.802116925888;5656.604037717402;5122.590192784643;5173.3533308336455;5174.534291913746;5334.359876814807;5390.865228369322;4753.667243293005;4775.6657034007985;4799.3760811094335;4826.300186472942;4833.468318484964;5640.520555752807;5663.716814159276;5681.715914204273;5683;5684.34630017545;5485.067538518541;5488.5334746545395;5490.231367608458;5491.121420572689;5494.313210848644;5682.8579285516535;5683.403242659461;5688.7440065198;5689.715514224355;5691.971540142273;5466.535344495604;5509.146082357241;5512.50387465114;5591.412901645269;5594.636348637326;5608.4111168326735;5611.046122159324;5612.7193640317;5617.185508101385;5671;5472.288602481652;5477.863053423696;5484;5485.314335708036;5492.395836458067;5243.187305967581;5286.048511267855;5373.2746079278795;5396.163594642837;5544.417836127149;5398.46015398457;5407.378151512469;5453.291072160594;5454.3454785426;5468.125099983983;5477.4796394342475;5505.889882202254;5513.42109078557;5516.200150978166;5518.834434966958;5241.60687948413;5271.78912843482;5383.111786555174;5394.0290747665795;5446.373667028342 00:45:35 INFO - PROCESS | 3388 | |1;ext.html;561.0652337113281;586.4047991288843;593.2880543347981;594.598645914008;611.6421893192484;31756;32368;43014.784926075365;44381.33427998574;44468.77765611176;40836.38745418821;44500.777496112554;44525;44590.55409445905;44613.33080003803;8764.780880478007;8920.553972301392;8924.375293729441;8931.464112153291;8968.955155224216;8718.520481373522;8816.338774591899;8820.823583528325;8840.602172902234;8895.599698013573;8899.15458031486;8950.776230594221;8956.19394254517;8956.686515971942;8956.731298061068;8878.644854205824;8918.375713700043;8924;8927.955360223223;8929.196372326522;8840.8673869892;8899.199072083478;8911.955440222822;8921.107889211093;8921.420107693044;42293.57706422927;42589.14821703579;42784.144317113794;42818.78590607058;42867;3498.5276987606603;3580.4987301777774;3588.766730162531;3627.6916462100753;3928.4129271613015;31324.686753132406;31378;31994.520082198786;32151.678483215102;32167.83916080428;4157.168566286755;4223.97888010558;4430.933535996963;4435.556444355571;4446.710963787344;317305;317671;317731;318322;318780;55643.44356556382;55926;55967.160492592644;55998;56083.15875261874;59696.40303596995;59845;60095.699521502116;60169.699151504836;60245.69877150674;14922.626934326512;15111.39554417833;15120.924395378173;15133.772993405108;15137.167455789817;11541.192116551929;11544.19190656646;11566.710832229262;11607.187496875138;11609.071274298036;15990.920045399698;16785.244663989906;16791;16794.16029198535;16807.386411921496;5831.475167234969;5832.708364581838;5995.400459954057;6090.908636370458;6140.2017737694705;919.5999740112939;1012.2458768217725;1061.5594528270835;1072.083368719749;1141.0358247281035;30658.233544161576;31531.21171970673;31776;32328.83835580807;32376.83811580927;1056.3978532236706;1093.1091160704;1111.1166374049267;1153.7461758413135;1171.841801356806;16070.75893861593;16643.251053702614;17093.914530427268;17360.305587776602;17606.471805845846;478758;482237;483482;483625;483731;58367;58658.413415865296;58660.41339586635;58666.49335846279;58732;1224.7244370016854;1229.9938500307442;1331.7469680760626;1333.8599447058114;1334.786434170528;28912.566311505765;32472.83763581167;32712.672873270963;32806.67193328036;33011.66988330086;48323.51676483331;48937.2659410102;49055;49145.75427122841;49154.50845491499;362569;362656.37343626225;363433;363757;364567;27516.449671006867;27762;28058.85970570134;28321.575176372782;29735.70264297416;46921;47151.76424117857;47153.52846471492;47489.28766068443;48303.275450867564;39990.40014399728;40284;40777.30073921621;42128.57871421369;42421.575784241766;39049.8047509772;40028.399574006995;40475.3928691064;40868.1826363477;41726.37410438906;39532.60467395289;39890.40164397479;40684.59315406808;40725.59274407218;41057.794711026254;32420.83789581037;36379.27241455209;36433.81783091067;36968.44547331846;37482.00287953914;27189;27560.448791024468;27708;27744;27870.3032424191 00:45:35 INFO - PROCESS | 3388 | |2;jquery.html;399.5425238102373;405.7038361995745;407.41739312782715;410.7473903549317;432.33204698740445;13012.544560940369;17192.398266060674;18583.72124418135;19043.333483328086;19050.04749762513;14735.263236838142;16528.173591320417;17859.91070044651;17929.10354482277;18609.069546522653;5311.601629877765;5654.9151762723595;5701.8311246194635;5704.429557044283;5708.914366284509;5477.561795056406;5582;5658.830235092953;5663.7168141592965;5675.631083979549;5617.775288988436;5656.91514627281;5658.8019419320335;5663.377028526858;5663.405342439026;5477.452254774491;5651.2935883014625;5661.264035675356;5662.065759149736;5669.801556945507;5078.923816142761;5083.72039537829;5088.211327244283;5099.643024988252;5114.411842638107;21245.893770531202;21823.23618673339;21864;22027.118915243373;22397.104115835347;2161.643328850738;2302.4934514406973;2545.083769842855;2667.1692199348204;2915.629654062587;9910.801783964353;9992.100710935978;10323.84514232287;10343.741406464824;10432.061114499731;1881.2192939930048;1909.102721720789;1923.7111135539221;1942.155162504315;1944.2903340280836;70598;74453.62773186153;80608.59695701543;80893.19106808916;81896.59051704763;10107.545160467796;10112.898871011343;10484.689413823273;10826.458677066274;11018.834717479243;14052.578422647337;14057.78913316301;14065.789013164811;14066.859331406555;14074.366653500618;6690.0968369270495;7051.43588512928;7068.681909314093;7155.248698886646;7554.773356799305;6991.335823096798;7086.114235720535;7094.184168820651;7198.352148306678;7284.6721897514735;4642.326862604971;4705.976470117627;4723.7401942893475;4762.023138917991;4860.198067318924;1972.2308299763104;1998.540335722792;2015.4961259685078;2016.8386529077638;2028.198861449719;843.3127001493763;927.8422668146432;1032.4579595712312;1067.8558394616782;1072.9141668666489;18092.36676716335;18274;18315.63368732618;18419.815801842076;18743.906280468782;929.2983797233046;940.7648087978006;955.3599088610648;960.6253561111172;983.2674657380297;10094.14199793026;10467.162626989822;10467.267291289536;10489.611508784465;10551.419671918118;417964;427228;432012;432550;433505;80104;85042;87159.12840871637;87306.12693873107;87354.56322718346;1006.854006169116;1026.8408396698524;1027.3579013116803;1040.3497813866334;1061.177587369779;15885.920570397537;16145.434909778101;16149.111798851176;16412.507624771275;16469.83530164683;39345.60654393534;39761;40173;40197.79901100476;40249.59750402458;40538.59461405348;41314.38028429636;44389;55733.442665572824;56129;6827.419669328163;8098.959505202436;8125.75622731319;8430.704925327584;8541.914580854113;12005.339706316236;12255.938720306342;12348.259104453402;12426.378681066091;12842.486300548248;10244.64143754965;10678.359298442118;10963.890361096606;11045.723856903642;11051.778964420828;10090.293679442662;10784.622538211124;10972.835407468734;10984.670459886216;11034.889651103385;10723;10831.241813073324;10973.177011723992;11141.554337826396;11329.886701132884;8287.792805179677;8291.41960062814;8350.540720260444;8646.610902509276;8707.259882910024;9678.564464598969;10871.782564348827;11093.11255099574;11674.533018679498;11850.466728997044 00:45:35 INFO - PROCESS | 3388 | |3;mootools.html;1447.4716728394137;1470.6690994526232;1593.6175317923694;1730.0830559803308;1740.8818074859919;7328.120625524931;7499.325060744532;7982.52104873708;8528.232459078681;8533.91466085339;7770.067591888967;8073.838523229532;8089.959550202241;8092.433529652927;8328.875066874001;2190.1896298369625;2236.1167338901123;2269.205777977703;2269.3305474884946;2279.122537822942;1932.053293886;2229.041512149775;2281.9201327953524;2285.485765702712;2288;1939.6896496560553;2115.598036373092;2207.4922767763424;2208.249195273607;2221.80003799658;2229.866208027507;2241.5180736141806;2245.191730976847;2247.8538894971775;2253.4479052632046;2185.0276626901036;2203.790639889208;2209.9668504972437;2214.6345852934246;2215.9113635454564;8046.959765201136;8186.795330116735;8200.343972482187;8202.220789025092;8202.482540729925;4862.051899879525;4958.3306253655655;5019.121653710623;5022.874428139289;5026.371703537058;3118.672539383355;3188.7289580385695;3346.7991920484606;3364.52896594477;3372.5615669962995;1083.3012706804145;1106.5186643809968;1107.617871834216;1112.4326593437324;1150.0741902768268;10962;11214.27107238035;11268.09855211581;11346.659600212008;11359.659210223625;4214.7471151731;4383.211022016068;4435.046465010038;4521.231390663595;4546.727196368229;9759.707208783748;9770.413775173512;9771.12059914611;9775.31572789912;9782.315237933419;5046.899062018739;5047.192449208109;5047.2429135629945;5049.293098966147;5053.418856831438;4516.119356725407;4610.354550362952;4668.066386722669;4670.859874203779;4674.345591617176;3802.125511132455;3821.2548553032448;3831.578526362098;3909.9413508797393;3976.920461590752;1232.9260244385366;1240.8821161989597;1241.1746188784539;1247.376311844078;1267.8478582569967;748.3788455581854;795.8806179073185;823.2048318544503;846.8645016797406;917.5366439947784;5238.76425560843;5276.683398996072;5301.946980530145;5334.493223143795;5446.7276636168035;875.0593112404191;897.2597606974273;899.4962820820231;903.8689390038408;945.7068308824287;3577.141486043331;3591.8742844000335;3595.8921232363073;3629.909252268714;3667.908302292464;9951.353162044445;10333.070023697903;10348.327358721659;10359.63741269067;10389.220808439397;10272;10286;10300;10308.690739277683;10319.84520232197;7298.23368546295;7668.884966725504;7679.308862202429;7817.296443320129;7835;5173.767180476812;5357.464253574612;5361.222622719762;5445.50990410865;5497.45025497447;9306.627734890528;9410.106039926197;9413.81172376535;9476.57355418994;9477.289203309641;9048.321375896965;9545;9635.181009614262;9669.854952175583;9758.121769040821;7098.6450677466955;7496.100467943882;7496.437767167593;7502.287282708134;7505;7887.566183859943;7900.446968712135;7942.404319675932;7955.5624440654;8071.313938315309;7361.374283185989;7372.152202496782;7377.5204611700065;7386.778396648109;7425.183229844821;7119.012306486542;7220.097487814023;7270.781876543712;7293.52592081513;7310.744123955636;6306.810795676137;6396.584222025554;6398.360163983564;6401.29585745577;6404.455621272058;4715.905681886412;4755.358026666356;4765.76171191446;4781.13939490895;4807.158747219292;4744.620430365631;4797.712137271775;4876.927076043265;4885.975570122127;5050.065737838511 00:45:35 INFO - PROCESS | 3388 | |4;prototype.html;303.40835371026503;318.2203601177116;322.62736539297106;322.6869936161923;324.28980532633545;4664.603508701764;4884.511548845123;5024.7738851751665;5083.262926875605;5090.160123579614;4998.800047998076;5062.620568332887;5087.6184286178595;5099.541041306282;5104.770285337159;4015.4980627421573;4016.3975403689387;4016.7188296819236;4018.236535058344;4037.3338399164104;3895.454636350899;4056.736312139716;4059.4316795648633;4066.166435880652;4073.9388909166387;3798.2973149967206;3980.8805735827973;3984.9278375244853;3996.7601943883315;4007.5591684914634;3951.9802400988096;3954.4463775071513;3965.9291991162227;3973.7615743055508;3976.880693579197;3494.860205591773;3502.8598856045983;3512.5082488451635;3512.5082488451635;3514.6309637487952;4765.7140571565815;4879.463259041502;4918.803247870081;4940.382452193476;4941.20940649498;4538.591526762574;4552.226121559343;4557.225271703785;4559.224931761609;4561.315802629632;5264.210368444726;5266.499682530153;5280.973595132038;5316;5326.733663316819;3819.4080964273576;3844.9231015379814;3874.2057878134915;3893.532776066862;3896.5908579599018;5119.2321151827155;5274.314339135926;5382.865428364283;5391.299131112969;5423.945760542383;3864.091938394475;3961.504811898513;3962.920741585152;3965.2862484753023;3967.441000554626;3993.880183594497;4000.319945609195;4004.2191772604647;4005.218982298482;4013.678905687538;4516.864494065183;4522.841700540531;4524.954750452519;4531.252343363308;4539.477960034638;5085.669431486942;5293.761780719877;5361.900810333872;5367.1680889462195;5423.674579525241;1354.552997510819;1369.965675914698;1370.8080868678394;1371.0745246958263;1371.2184055088703;832.7543374704477;877.3814460805118;880.9207171354609;889.4885440871525;891.8806897343792;4545.840895568639;4550.931736023962;4557.453105627346;4576.908461830745;4591.931121033187;4771.308160316735;4780.44635493466;4790.113828941657;4824.710517368969;4831.758412079382;4399.84407640254;4552.658550608651;4557.908841823145;4566.520515345841;4580.305287043815;2506.398464368575;2542.6142752200094;2548.241713217874;2557.514072326252;2573.3695244664805;4872.366592342973;4909.70541767488;4925.261210818334;4961.925571116436;4975.651704380659;4606.95393046072;4861.683990540603;4903.26451032348;4906.828261010847;4906.877328066756;4886.780094895738;4936.136176169156;4936.506349365035;4939.456659767351;4950.935548856941;4776;4789.61683065347;4803.303520989507;4820.783064762024;4876.780544875418;4502.4371953505815;4773.641976851681;4782.832600859092;4793.544613261734;4806.7836947338155;4860.902781944412;4903.754812259444;5296.814611488733;5448.700321482356;5463.836084917459;3756.812159392074;3759.9436008459347;3789.5452545694693;3811.1805961718364;3816.2939856126704;5383.16560933056;5417;5418.295621569171;5431.511163995259;5438.211459338295;5133.75167594559;5272.6836389816735;5279.841604751864;5288.920666189933;5291.365036195527;5264.447233040476;5278.366596008504;5288.576913846806;5304.814331498379;5313.335833020872;5278.3637072507645;5290.576753859759;5293.761780719954;5297.205419187153;5307.6284660073425;5157.329547158845;5247.842564722911;5264.289320941777;5274.86812829667;5277.815276465305;5148.897022059463;5189.76646050921;5204.843854684214;5229.869253268546;5231.29377534028 00:45:35 INFO - PROCESS | 3388 | |5;yui.html;744.5263434437564;787.9960600196998;827;830.4643504939311;848.1094850407075;16194.271257793398;17087.14564271788;17107;17113.65772684547;17129.229184686686;14876;15041.323140458679;15088.924555377234;15098.396064157421;15100.773488397655;656.1175219329994;792.0693185507021;804.0512195609178;804.6017221475378;805.5931754464017;655.6983787457775;792.4017366887991;794.5550491724653;799.5282783157936;815.3273549321804;856.648774002659;860.4837097741367;861.3453775130914;862.211076864668;863.1497974495118;695.2213520856623;850.3664769746548;851.7572491839858;851.9659213631447;852.4246133859651;520.1573451009351;605.7001784116846;606.2421972534332;611.6727550760322;622.396275612655;15058.924705376512;15078.623034424227;15116.244187790677;15118;15121.16833574153;13797.172169669851;14265.928670356685;14479.05886117399;14550;14765.261736913219;11740.941295293469;12376;12759.234445933274;13392.531261405804;13467.326633668277;4369.781510924441;4377.212101821671;4462.2191116554795;4463.24124898768;4579.576597688391;79133.60433197797;80172;80486;81308.59345703293;81435.59282203669;11384.373859437645;11639.301641901344;11692.356920369291;11973.940130299292;12015.639530814089;21691.457713557287;21775.346739597837;21872.562548749254;21909.780902191094;21998.45003874916;8377;8399.95800020996;8403.495790252604;8492.150784921581;8695.13048695138;4533.38799262102;4651.488336283074;4671.299305104261;4675.906481870344;4704.811807527729;3294;3366.9326613467592;3405.965940340565;3406.608240052376;3409.079548521885;653.3433898931544;683.7504310926475;693.237438817297;702.2240424331143;706.1279320039747;734.6033142103312;765.3226894198674;776.6932061835544;778.307306497218;810.5177419435427;9300.90699093014;10263.589456421809;10357.430341331148;10376.533056012497;10462.790744185073;642.9710663020176;684.4592771710293;738.2838646512874;747.2564798025999;753.4048101999359;4767.69010014348;4901.828436004723;4918.360613120271;4958.157113290749;4959.156943319645;71634.64182679054;79882.60058699669;120157.39921300512;133170.33414832863;133485.33257333652;84403.5779821097;84552.15447845566;85870.57064714636;97662.5116874411;111847;52568.737156313975;52603.94792104136;81209.18790812134;82273.58863205646;84067.57966210252;9332.813343733224;9698.818299168208;9779.476536721573;9813.473207652603;9830.954207218112;44366;45865.54134458613;47715;48003.75998119987;49304.506954929995;64086;71796.28203718105;72213.638931805;74851.2514874866;75444;12741.235525868478;12984.220946743226;13242.668933276746;13312.936494842927;13783.104098233583;13935.930320348334;14989.250537473301;15005.174715390758;15284.15937123469;15421.151836649093;13573.59279221625;13662;13855.861441385458;14077.718445631235;14676.486322978644;12988.285644289277;13441.59675209706;13482.460701571827;13768.24274664903;14050.297485125908;13111.2133272004;13219.801702974655;13614;13844.584662460142;13958.511452099128;10436;10526.842097368393;10815.837762433412;11168.776624467628;11415.828762568402;10053.648122315684;10168.631042446468;10885.183611229031;11399.699224236887;11880.405979701154 00:45:35 INFO - PROCESS | 3388 | __end_tp_report 00:45:35 INFO - PROCESS | 3388 | __start_cc_report 00:45:35 INFO - PROCESS | 3388 | _x_x_mozilla_cycle_collect,1213 00:45:35 INFO - PROCESS | 3388 | __end_cc_report 00:45:35 INFO - PROCESS | 3388 | __startTimestamp1475653535593__endTimestamp 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | ------- Summary: start ------- 00:45:35 INFO - PROCESS | 3388 | Number of tests: 6 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | [#0] dojo.html Cycles:165 Average:5188.43 Median:5396.16 stddev:576.26 (10.7%) stddev-sans-first:551.10 00:45:35 INFO - PROCESS | 3388 | Values: 2969.2 3006.7 3007.0 3016.2 3040.2 5136.3 5195.4 5238.6 5243.7 5285.2 5157.7 5213.3 5226.9 5261.2 5305.2 4663.0 4698.5 4718.7 4724.6 4792.0 4868.1 4897.1 4909.8 4928.0 4961.8 4683.1 4722.0 4732.7 4768.2 4796.7 4718.2 4735.8 4747.9 4753.0 4769.9 4667.0 4677.1 4683.0 4740.0 4767.5 5214.6 5219.9 5225.5 5226.7 5274.5 5459.6 5515.2 5567.7 5617.7 5626.0 5626.7 5660.7 5672.8 5676.3 5683.6 5291.1 5303.7 5306.2 5308.9 5369.9 5484.1 5527.6 5627.8 5689.7 5690.0 5490.0 5490.5 5490.6 5494.1 5553.4 5520.6 5525.5 5531.9 5551.9 5592.7 5414.5 5427.5 5531.5 5575.6 5592.9 5618.5 5619.0 5622.4 5623.0 5682.9 4353.8 4358.1 4358.3 4364.0 4404.5 3822.8 3824.1 3826.4 3857.7 3863.5 5315.4 5322.3 5322.5 5363.8 5387.2 5615.7 5624.2 5631.8 5653.8 5656.6 5122.6 5173.4 5174.5 5334.4 5390.9 4753.7 4775.7 4799.4 4826.3 4833.5 5640.5 5663.7 5681.7 5683.0 5684.3 5485.1 5488.5 5490.2 5491.1 5494.3 5682.9 5683.4 5688.7 5689.7 5692.0 5466.5 5509.1 5512.5 5591.4 5594.6 5608.4 5611.0 5612.7 5617.2 5671.0 5472.3 5477.9 5484.0 5485.3 5492.4 5243.2 5286.0 5373.3 5396.2 5544.4 5398.5 5407.4 5453.3 5454.3 5468.1 5477.5 5505.9 5513.4 5516.2 5518.8 5241.6 5271.8 5383.1 5394.0 5446.4 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | [#1] ext.html Cycles:180 Average:55341.41 Median:40806.84 stddev:104099.67 (255.1%) stddev-sans-first:104310.45 00:45:35 INFO - PROCESS | 3388 | Values: 561.1 586.4 593.3 594.6 611.6 31756.0 32368.0 43014.8 44381.3 44468.8 40836.4 44500.8 44525.0 44590.6 44613.3 8764.8 8920.6 8924.4 8931.5 8969.0 8718.5 8816.3 8820.8 8840.6 8895.6 8899.2 8950.8 8956.2 8956.7 8956.7 8878.6 8918.4 8924.0 8928.0 8929.2 8840.9 8899.2 8912.0 8921.1 8921.4 42293.6 42589.1 42784.1 42818.8 42867.0 3498.5 3580.5 3588.8 3627.7 3928.4 31324.7 31378.0 31994.5 32151.7 32167.8 4157.2 4224.0 4430.9 4435.6 4446.7 317305.0 317671.0 317731.0 318322.0 318780.0 55643.4 55926.0 55967.2 55998.0 56083.2 59696.4 59845.0 60095.7 60169.7 60245.7 14922.6 15111.4 15120.9 15133.8 15137.2 11541.2 11544.2 11566.7 11607.2 11609.1 15990.9 16785.2 16791.0 16794.2 16807.4 5831.5 5832.7 5995.4 6090.9 6140.2 919.6 1012.2 1061.6 1072.1 1141.0 30658.2 31531.2 31776.0 32328.8 32376.8 1056.4 1093.1 1111.1 1153.7 1171.8 16070.8 16643.3 17093.9 17360.3 17606.5 478758.0 482237.0 483482.0 483625.0 483731.0 58367.0 58658.4 58660.4 58666.5 58732.0 1224.7 1230.0 1331.7 1333.9 1334.8 28912.6 32472.8 32712.7 32806.7 33011.7 48323.5 48937.3 49055.0 49145.8 49154.5 362569.0 362656.4 363433.0 363757.0 364567.0 27516.4 27762.0 28058.9 28321.6 29735.7 46921.0 47151.8 47153.5 47489.3 48303.3 39990.4 40284.0 40777.3 42128.6 42421.6 39049.8 40028.4 40475.4 40868.2 41726.4 39532.6 39890.4 40684.6 40725.6 41057.8 32420.8 36379.3 36433.8 36968.4 37482.0 27189.0 27560.4 27708.0 27744.0 27870.3 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | [#2] jquery.html Cycles:180 Average:26230.41 Median:39553.30 stddev:70816.09 (179.0%) stddev-sans-first:70988.19 00:45:35 INFO - PROCESS | 3388 | Values: 399.5 405.7 407.4 410.7 432.3 13012.5 17192.4 18583.7 19043.3 19050.0 14735.3 16528.2 17859.9 17929.1 18609.1 5311.6 5654.9 5701.8 5704.4 5708.9 5477.6 5582.0 5658.8 5663.7 5675.6 5617.8 5656.9 5658.8 5663.4 5663.4 5477.5 5651.3 5661.3 5662.1 5669.8 5078.9 5083.7 5088.2 5099.6 5114.4 21245.9 21823.2 21864.0 22027.1 22397.1 2161.6 2302.5 2545.1 2667.2 2915.6 9910.8 9992.1 10323.8 10343.7 10432.1 1881.2 1909.1 1923.7 1942.2 1944.3 70598.0 74453.6 80608.6 80893.2 81896.6 10107.5 10112.9 10484.7 10826.5 11018.8 14052.6 14057.8 14065.8 14066.9 14074.4 6690.1 7051.4 7068.7 7155.2 7554.8 6991.3 7086.1 7094.2 7198.4 7284.7 4642.3 4706.0 4723.7 4762.0 4860.2 1972.2 1998.5 2015.5 2016.8 2028.2 843.3 927.8 1032.5 1067.9 1072.9 18092.4 18274.0 18315.6 18419.8 18743.9 929.3 940.8 955.4 960.6 983.3 10094.1 10467.2 10467.3 10489.6 10551.4 417964.0 427228.0 432012.0 432550.0 433505.0 80104.0 85042.0 87159.1 87306.1 87354.6 1006.9 1026.8 1027.4 1040.3 1061.2 15885.9 16145.4 16149.1 16412.5 16469.8 39345.6 39761.0 40173.0 40197.8 40249.6 40538.6 41314.4 44389.0 55733.4 56129.0 6827.4 8099.0 8125.8 8430.7 8541.9 12005.3 12255.9 12348.3 12426.4 12842.5 10244.6 10678.4 10963.9 11045.7 11051.8 10090.3 10784.6 10972.8 10984.7 11034.9 10723.0 10831.2 10973.2 11141.6 11329.9 8287.8 8291.4 8350.5 8646.6 8707.3 9678.6 10871.8 11093.1 11674.5 11850.5 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | [#3] mootools.html Cycles:180 Average:5434.97 Median:5021.00 stddev:3058.17 (60.9%) stddev-sans-first:3052.06 00:45:35 INFO - PROCESS | 3388 | Values: 1447.5 1470.7 1593.6 1730.1 1740.9 7328.1 7499.3 7982.5 8528.2 8533.9 7770.1 8073.8 8090.0 8092.4 8328.9 2190.2 2236.1 2269.2 2269.3 2279.1 1932.1 2229.0 2281.9 2285.5 2288.0 1939.7 2115.6 2207.5 2208.2 2221.8 2229.9 2241.5 2245.2 2247.9 2253.4 2185.0 2203.8 2210.0 2214.6 2215.9 8047.0 8186.8 8200.3 8202.2 8202.5 4862.1 4958.3 5019.1 5022.9 5026.4 3118.7 3188.7 3346.8 3364.5 3372.6 1083.3 1106.5 1107.6 1112.4 1150.1 10962.0 11214.3 11268.1 11346.7 11359.7 4214.7 4383.2 4435.0 4521.2 4546.7 9759.7 9770.4 9771.1 9775.3 9782.3 5046.9 5047.2 5047.2 5049.3 5053.4 4516.1 4610.4 4668.1 4670.9 4674.3 3802.1 3821.3 3831.6 3909.9 3976.9 1232.9 1240.9 1241.2 1247.4 1267.8 748.4 795.9 823.2 846.9 917.5 5238.8 5276.7 5301.9 5334.5 5446.7 875.1 897.3 899.5 903.9 945.7 3577.1 3591.9 3595.9 3629.9 3667.9 9951.4 10333.1 10348.3 10359.6 10389.2 10272.0 10286.0 10300.0 10308.7 10319.8 7298.2 7668.9 7679.3 7817.3 7835.0 5173.8 5357.5 5361.2 5445.5 5497.5 9306.6 9410.1 9413.8 9476.6 9477.3 9048.3 9545.0 9635.2 9669.9 9758.1 7098.6 7496.1 7496.4 7502.3 7505.0 7887.6 7900.4 7942.4 7955.6 8071.3 7361.4 7372.2 7377.5 7386.8 7425.2 7119.0 7220.1 7270.8 7293.5 7310.7 6306.8 6396.6 6398.4 6401.3 6404.5 4715.9 4755.4 4765.8 4781.1 4807.2 4744.6 4797.7 4876.9 4886.0 5050.1 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | [#4] prototype.html Cycles:180 Average:4308.89 Median:4791.83 stddev:1230.09 (25.7%) stddev-sans-first:1196.23 00:45:35 INFO - PROCESS | 3388 | Values: 303.4 318.2 322.6 322.7 324.3 4664.6 4884.5 5024.8 5083.3 5090.2 4998.8 5062.6 5087.6 5099.5 5104.8 4015.5 4016.4 4016.7 4018.2 4037.3 3895.5 4056.7 4059.4 4066.2 4073.9 3798.3 3980.9 3984.9 3996.8 4007.6 3952.0 3954.4 3965.9 3973.8 3976.9 3494.9 3502.9 3512.5 3512.5 3514.6 4765.7 4879.5 4918.8 4940.4 4941.2 4538.6 4552.2 4557.2 4559.2 4561.3 5264.2 5266.5 5281.0 5316.0 5326.7 3819.4 3844.9 3874.2 3893.5 3896.6 5119.2 5274.3 5382.9 5391.3 5423.9 3864.1 3961.5 3962.9 3965.3 3967.4 3993.9 4000.3 4004.2 4005.2 4013.7 4516.9 4522.8 4525.0 4531.3 4539.5 5085.7 5293.8 5361.9 5367.2 5423.7 1354.6 1370.0 1370.8 1371.1 1371.2 832.8 877.4 880.9 889.5 891.9 4545.8 4550.9 4557.5 4576.9 4591.9 4771.3 4780.4 4790.1 4824.7 4831.8 4399.8 4552.7 4557.9 4566.5 4580.3 2506.4 2542.6 2548.2 2557.5 2573.4 4872.4 4909.7 4925.3 4961.9 4975.7 4607.0 4861.7 4903.3 4906.8 4906.9 4886.8 4936.1 4936.5 4939.5 4950.9 4776.0 4789.6 4803.3 4820.8 4876.8 4502.4 4773.6 4782.8 4793.5 4806.8 4860.9 4903.8 5296.8 5448.7 5463.8 3756.8 3759.9 3789.5 3811.2 3816.3 5383.2 5417.0 5418.3 5431.5 5438.2 5133.8 5272.7 5279.8 5288.9 5291.4 5264.4 5278.4 5288.6 5304.8 5313.3 5278.4 5290.6 5293.8 5297.2 5307.6 5157.3 5247.8 5264.3 5274.9 5277.8 5148.9 5189.8 5204.8 5229.9 5231.3 00:45:35 INFO - PROCESS | 3388 | 00:45:35 INFO - PROCESS | 3388 | [#5] yui.html Cycles:180 Average:20042.69 Median:25258.51 stddev:28411.32 (112.5%) stddev-sans-first:28454.06 00:45:35 INFO - PROCESS | 3388 | Values: 744.5 788.0 827.0 830.5 848.1 16194.3 17087.1 17107.0 17113.7 17129.2 14876.0 15041.3 15088.9 15098.4 15100.8 656.1 792.1 804.1 804.6 805.6 655.7 792.4 794.6 799.5 815.3 856.6 860.5 861.3 862.2 863.1 695.2 850.4 851.8 852.0 852.4 520.2 605.7 606.2 611.7 622.4 15058.9 15078.6 15116.2 15118.0 15121.2 13797.2 14265.9 14479.1 14550.0 14765.3 11740.9 12376.0 12759.2 13392.5 13467.3 4369.8 4377.2 4462.2 4463.2 4579.6 79133.6 80172.0 80486.0 81308.6 81435.6 11384.4 11639.3 11692.4 11973.9 12015.6 21691.5 21775.3 21872.6 21909.8 21998.5 8377.0 8400.0 8403.5 8492.2 8695.1 4533.4 4651.5 4671.3 4675.9 4704.8 3294.0 3366.9 3406.0 3406.6 3409.1 653.3 683.8 693.2 702.2 706.1 734.6 765.3 776.7 778.3 810.5 9300.9 10263.6 10357.4 10376.5 10462.8 643.0 684.5 738.3 747.3 753.4 4767.7 4901.8 4918.4 4958.2 4959.2 71634.6 79882.6 120157.4 133170.3 133485.3 84403.6 84552.2 85870.6 97662.5 111847.0 52568.7 52603.9 81209.2 82273.6 84067.6 9332.8 9698.8 9779.5 9813.5 9831.0 44366.0 45865.5 47715.0 48003.8 49304.5 64086.0 71796.3 72213.6 74851.3 75444.0 12741.2 12984.2 13242.7 13312.9 13783.1 13935.9 14989.3 15005.2 15284.2 15421.2 13573.6 13662.0 13855.9 14077.7 14676.5 12988.3 13441.6 13482.5 13768.2 14050.3 13111.2 13219.8 13614.0 13844.6 13958.5 10436.0 10526.8 10815.8 11168.8 11415.8 10053.6 10168.6 10885.2 11399.7 11880.4 00:45:35 INFO - PROCESS | 3388 | -------- Summary: end -------- 00:45:35 INFO - PROCESS | 3388 | 00:45:36 INFO - TEST-INFO | 3388: exit 0 00:45:36 INFO - TEST-OK | dromaeo_css | took 1119087ms 00:45:36 INFO - TEST-START | kraken 00:45:36 INFO - operating with platform_type : linux_ 00:45:36 INFO - Initialising browser for kraken test... 00:45:36 INFO - TEST-INFO | started process 3690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo1DsLe/profile http://localhost:49554/getInfo.html) 00:45:40 INFO - PROCESS | 3690 | __metrics Screen width/height:1600/1200 00:45:40 INFO - PROCESS | 3690 | colorDepth:24 00:45:40 INFO - PROCESS | 3690 | Browser inner width/height: 1024/697 00:45:40 INFO - PROCESS | 3690 | __metrics 00:45:41 INFO - PROCESS | 3690 | 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" 00:45:41 INFO - PROCESS | 3690 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:45:41 INFO - PROCESS | 3690 | console.error: PushService: 00:45:41 INFO - PROCESS | 3690 | stateChangeProcessEnqueue: Error transitioning state 00:45:41 INFO - PROCESS | 3690 | UnknownError 00:45:42 INFO - TEST-INFO | 3690: exit 0 00:45:42 INFO - Browser initialized. 00:45:42 INFO - Running cycle 1/1 for kraken test... 00:45:42 INFO - TEST-INFO | started process 3772 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo1DsLe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:45:54 INFO - PROCESS | 3772 | RSS: Main: 174387200 00:45:54 INFO - PROCESS | 3772 | 00:45:57 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49554/tests/kraken/driver.html?testName=audio-beat-detection) 00:45:58 INFO - PROCESS | 3772 | RSS: Main: 233328640 00:45:58 INFO - PROCESS | 3772 | 00:46:00 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49554/tests/kraken/driver.html?testName=audio-dft) 00:46:01 INFO - PROCESS | 3772 | RSS: Main: 218202112 00:46:01 INFO - PROCESS | 3772 | 00:46:04 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49554/tests/kraken/driver.html?testName=audio-fft) 00:46:05 INFO - PROCESS | 3772 | RSS: Main: 299155456 00:46:05 INFO - PROCESS | 3772 | 00:46:07 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49554/tests/kraken/driver.html?testName=audio-oscillator) 00:46:07 INFO - PROCESS | 3772 | RSS: Main: 211062784 00:46:07 INFO - PROCESS | 3772 | 00:46:09 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:46:10 INFO - PROCESS | 3772 | RSS: Main: 213458944 00:46:10 INFO - PROCESS | 3772 | 00:46:13 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49554/tests/kraken/driver.html?testName=imaging-darkroom) 00:46:14 INFO - PROCESS | 3772 | RSS: Main: 249241600 00:46:14 INFO - PROCESS | 3772 | 00:46:17 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49554/tests/kraken/driver.html?testName=imaging-desaturate) 00:46:18 INFO - PROCESS | 3772 | RSS: Main: 248971264 00:46:18 INFO - PROCESS | 3772 | 00:46:20 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49554/tests/kraken/driver.html?testName=json-parse-financial) 00:46:21 INFO - PROCESS | 3772 | RSS: Main: 248700928 00:46:21 INFO - PROCESS | 3772 | 00:46:23 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:46:23 INFO - PROCESS | 3772 | RSS: Main: 210796544 00:46:23 INFO - PROCESS | 3772 | 00:46:25 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:46:26 INFO - PROCESS | 3772 | RSS: Main: 218497024 00:46:26 INFO - PROCESS | 3772 | 00:46:28 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:46:28 INFO - PROCESS | 3772 | RSS: Main: 227287040 00:46:28 INFO - PROCESS | 3772 | 00:46:31 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:46:32 INFO - PROCESS | 3772 | RSS: Main: 236687360 00:46:32 INFO - PROCESS | 3772 | 00:46:34 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:46:35 INFO - PROCESS | 3772 | RSS: Main: 233230336 00:46:35 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | Cycle 1(1): loaded http://localhost:49554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49554/tests/kraken/driver.html?testName=ai-astar) 00:46:37 INFO - PROCESS | 3772 | RSS: Main: 284512256 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | __start_tp_report 00:46:37 INFO - PROCESS | 3772 | _x_x_mozilla_page_load 00:46:37 INFO - PROCESS | 3772 | _x_x_mozilla_page_load_details 00:46:37 INFO - PROCESS | 3772 | |i|pagename|runs| 00:46:37 INFO - PROCESS | 3772 | |0;ai-astar;110;111;112;111;111;110;111;111;111;112 00:46:37 INFO - PROCESS | 3772 | |1;audio-beat-detection;153;126;124;171;130;127;123;126;167;121 00:46:37 INFO - PROCESS | 3772 | |2;audio-dft;161;162;162;162;159;163;161;161;160;163 00:46:37 INFO - PROCESS | 3772 | |3;audio-fft;76;76;75;111;75;77;76;77;101;76 00:46:37 INFO - PROCESS | 3772 | |4;audio-oscillator;84;84;122;84;82;82;106;83;82;119 00:46:37 INFO - PROCESS | 3772 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;116;116;117 00:46:37 INFO - PROCESS | 3772 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;145;145 00:46:37 INFO - PROCESS | 3772 | |7;imaging-desaturate;95;95;96;96;95;95;95;94;95;95 00:46:37 INFO - PROCESS | 3772 | |8;json-parse-financial;52;51;50;50;51;52;53;51;51;52 00:46:37 INFO - PROCESS | 3772 | |9;json-stringify-tinderbox;60;60;61;61;62;61;61;62;61;62 00:46:37 INFO - PROCESS | 3772 | |10;stanford-crypto-aes;80;79;79;80;80;79;86;79;80;79 00:46:37 INFO - PROCESS | 3772 | |11;stanford-crypto-ccm;133;147;136;136;138;134;136;130;164;135 00:46:37 INFO - PROCESS | 3772 | |12;stanford-crypto-pbkdf2;166;166;165;163;164;166;162;162;170;165 00:46:37 INFO - PROCESS | 3772 | |13;stanford-crypto-sha256-iterative;65;66;66;66;66;69;66;67;66;65 00:46:37 INFO - PROCESS | 3772 | __end_tp_report 00:46:37 INFO - PROCESS | 3772 | __start_cc_report 00:46:37 INFO - PROCESS | 3772 | _x_x_mozilla_cycle_collect,1623 00:46:37 INFO - PROCESS | 3772 | __end_cc_report 00:46:37 INFO - PROCESS | 3772 | __startTimestamp1475653597288__endTimestamp 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | ------- Summary: start ------- 00:46:37 INFO - PROCESS | 3772 | Number of tests: 14 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 00:46:37 INFO - PROCESS | 3772 | Values: 110.0 111.0 112.0 111.0 111.0 110.0 111.0 111.0 111.0 112.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:128.50 stddev:19.22 (15.0%) stddev-sans-first:19.47 00:46:37 INFO - PROCESS | 3772 | Values: 153.0 126.0 124.0 171.0 130.0 127.0 123.0 126.0 167.0 121.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 00:46:37 INFO - PROCESS | 3772 | Values: 161.0 162.0 162.0 162.0 159.0 163.0 161.0 161.0 160.0 163.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.88 (17.0%) stddev-sans-first:13.48 00:46:37 INFO - PROCESS | 3772 | Values: 76.0 76.0 75.0 111.0 75.0 77.0 76.0 77.0 101.0 76.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:82.50 stddev:16.30 (19.8%) stddev-sans-first:16.98 00:46:37 INFO - PROCESS | 3772 | Values: 84.0 84.0 122.0 84.0 82.0 82.0 106.0 83.0 82.0 119.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 00:46:37 INFO - PROCESS | 3772 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 00:46:37 INFO - PROCESS | 3772 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 00:46:37 INFO - PROCESS | 3772 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.50 stddev:0.95 (1.8%) stddev-sans-first:0.97 00:46:37 INFO - PROCESS | 3772 | Values: 52.0 51.0 50.0 50.0 51.0 52.0 53.0 51.0 51.0 52.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 00:46:37 INFO - PROCESS | 3772 | Values: 60.0 60.0 61.0 61.0 62.0 61.0 61.0 62.0 61.0 62.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:2.13 (2.7%) stddev-sans-first:2.26 00:46:37 INFO - PROCESS | 3772 | Values: 80.0 79.0 79.0 80.0 80.0 79.0 86.0 79.0 80.0 79.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#11] stanford-crypto-ccm Cycles:10 Average:138.90 Median:136.00 stddev:9.86 (7.2%) stddev-sans-first:10.22 00:46:37 INFO - PROCESS | 3772 | Values: 133.0 147.0 136.0 136.0 138.0 134.0 136.0 130.0 164.0 135.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.50 stddev:2.38 (1.4%) stddev-sans-first:2.49 00:46:37 INFO - PROCESS | 3772 | Values: 166.0 166.0 165.0 163.0 164.0 166.0 162.0 162.0 170.0 165.0 00:46:37 INFO - PROCESS | 3772 | 00:46:37 INFO - PROCESS | 3772 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 00:46:37 INFO - PROCESS | 3772 | Values: 65.0 66.0 66.0 66.0 66.0 69.0 66.0 67.0 66.0 65.0 00:46:37 INFO - PROCESS | 3772 | -------- Summary: end -------- 00:46:37 INFO - PROCESS | 3772 | 00:46:38 INFO - TEST-INFO | 3772: exit 0 00:46:38 INFO - TEST-OK | kraken | took 61962ms 00:46:38 INFO - SUITE-END | took 1181s 00:46:38 INFO - Completed test suite (00:19:41) 00:46:38 INFO - javascript benchmark 00:46:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2969.2280007198137, 3006.6692663806984, 3007.0, 3016.1554764665902, 3040.179151629061, 5136.33227680402, 5195.428502864686, 5238.554722848562, 5243.659162154458, 5285.23364112203, 5157.664751791131, 5213.348331458567, 5226.895462090756, 5261.2371206175085, 5305.1776974569, 4663.044075964436, 4698.483166851644, 4718.669693121483, 4724.5984091352275, 4792.017636384533, 4868.148074087038, 4897.118518666639, 4909.779059942293, 4927.950720492785, 4961.826336078238, 4683.1336202802595, 4722.03198344342, 4732.692374995614, 4768.189407800664, 4796.736179510125, 4718.174319494075, 4735.810567577328, 4747.905041899177, 4753.0, 4769.880752981168, 4667.043256132485, 4677.064587082563, 4682.953170468286, 4739.9526004739855, 4767.475577686451, 5214.582833373321, 5219.869503262411, 5225.451327610622, 5226.694904671761, 5274.472552744734, 5459.645123066988, 5515.172724091378, 5567.66594004361, 5617.719114044281, 5625.971870140664, 5626.746796394131, 5660.660360378391, 5672.8014519492035, 5676.290463692038, 5683.602147849652, 5291.100512912814, 5303.655262407931, 5306.151015837486, 5308.920366194471, 5369.865753356119, 5484.067708489566, 5527.640703354269, 5627.803026894039, 5689.715514224272, 5689.971550142222, 5489.972550137224, 5490.450954904558, 5490.588205884575, 5494.148406996922, 5553.361363443175, 5520.641158324696, 5525.475079867406, 5531.889362212733, 5551.944480555224, 5592.692401917933, 5414.512693857571, 5427.538659214011, 5531.474509921551, 5575.60970732053, 5592.86017849557, 5618.494335509742, 5619.044762390404, 5622.353429355595, 5622.971885140548, 5682.914756278659, 4353.825846966086, 4358.084802191575, 4358.302671572533, 4363.956360436418, 4404.53752355998, 3822.7897465639103, 3824.1395685970433, 3826.3877779555696, 3857.6528112470014, 3863.497745293094, 5315.362156541162, 5322.28149199853, 5322.494363035506, 5363.758630861543, 5387.164989426645, 5615.719214039364, 5624.156376543551, 5631.7747290108755, 5653.802116925888, 5656.604037717402, 5122.590192784643, 5173.3533308336455, 5174.534291913746, 5334.359876814807, 5390.865228369322, 4753.667243293005, 4775.6657034007985, 4799.3760811094335, 4826.300186472942, 4833.468318484964, 5640.520555752807, 5663.716814159276, 5681.715914204273, 5683.0, 5684.34630017545, 5485.067538518541, 5488.5334746545395, 5490.231367608458, 5491.121420572689, 5494.313210848644, 5682.8579285516535, 5683.403242659461, 5688.7440065198, 5689.715514224355, 5691.971540142273, 5466.535344495604, 5509.146082357241, 5512.50387465114, 5591.412901645269, 5594.636348637326, 5608.4111168326735, 5611.046122159324, 5612.7193640317, 5617.185508101385, 5671.0, 5472.288602481652, 5477.863053423696, 5484.0, 5485.314335708036, 5492.395836458067, 5243.187305967581, 5286.048511267855, 5373.2746079278795, 5396.163594642837, 5544.417836127149, 5398.46015398457, 5407.378151512469, 5453.291072160594, 5454.3454785426, 5468.125099983983, 5477.4796394342475, 5505.889882202254, 5513.42109078557, 5516.200150978166, 5518.834434966958, 5241.60687948413, 5271.78912843482, 5383.111786555174, 5394.0290747665795, 5446.373667028342], "value": 5149.991491179424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.0652337113281, 586.4047991288843, 593.2880543347981, 594.598645914008, 611.6421893192484, 31756.0, 32368.0, 43014.784926075365, 44381.33427998574, 44468.77765611176, 40836.38745418821, 44500.777496112554, 44525.0, 44590.55409445905, 44613.33080003803, 8764.780880478007, 8920.553972301392, 8924.375293729441, 8931.464112153291, 8968.955155224216, 8718.520481373522, 8816.338774591899, 8820.823583528325, 8840.602172902234, 8895.599698013573, 8899.15458031486, 8950.776230594221, 8956.19394254517, 8956.686515971942, 8956.731298061068, 8878.644854205824, 8918.375713700043, 8924.0, 8927.955360223223, 8929.196372326522, 8840.8673869892, 8899.199072083478, 8911.955440222822, 8921.107889211093, 8921.420107693044, 42293.57706422927, 42589.14821703579, 42784.144317113794, 42818.78590607058, 42867.0, 3498.5276987606603, 3580.4987301777774, 3588.766730162531, 3627.6916462100753, 3928.4129271613015, 31324.686753132406, 31378.0, 31994.520082198786, 32151.678483215102, 32167.83916080428, 4157.168566286755, 4223.97888010558, 4430.933535996963, 4435.556444355571, 4446.710963787344, 317305.0, 317671.0, 317731.0, 318322.0, 318780.0, 55643.44356556382, 55926.0, 55967.160492592644, 55998.0, 56083.15875261874, 59696.40303596995, 59845.0, 60095.699521502116, 60169.699151504836, 60245.69877150674, 14922.626934326512, 15111.39554417833, 15120.924395378173, 15133.772993405108, 15137.167455789817, 11541.192116551929, 11544.19190656646, 11566.710832229262, 11607.187496875138, 11609.071274298036, 15990.920045399698, 16785.244663989906, 16791.0, 16794.16029198535, 16807.386411921496, 5831.475167234969, 5832.708364581838, 5995.400459954057, 6090.908636370458, 6140.2017737694705, 919.5999740112939, 1012.2458768217725, 1061.5594528270835, 1072.083368719749, 1141.0358247281035, 30658.233544161576, 31531.21171970673, 31776.0, 32328.83835580807, 32376.83811580927, 1056.3978532236706, 1093.1091160704, 1111.1166374049267, 1153.7461758413135, 1171.841801356806, 16070.75893861593, 16643.251053702614, 17093.914530427268, 17360.305587776602, 17606.471805845846, 478758.0, 482237.0, 483482.0, 483625.0, 483731.0, 58367.0, 58658.413415865296, 58660.41339586635, 58666.49335846279, 58732.0, 1224.7244370016854, 1229.9938500307442, 1331.7469680760626, 1333.8599447058114, 1334.786434170528, 28912.566311505765, 32472.83763581167, 32712.672873270963, 32806.67193328036, 33011.66988330086, 48323.51676483331, 48937.2659410102, 49055.0, 49145.75427122841, 49154.50845491499, 362569.0, 362656.37343626225, 363433.0, 363757.0, 364567.0, 27516.449671006867, 27762.0, 28058.85970570134, 28321.575176372782, 29735.70264297416, 46921.0, 47151.76424117857, 47153.52846471492, 47489.28766068443, 48303.275450867564, 39990.40014399728, 40284.0, 40777.30073921621, 42128.57871421369, 42421.575784241766, 39049.8047509772, 40028.399574006995, 40475.3928691064, 40868.1826363477, 41726.37410438906, 39532.60467395289, 39890.40164397479, 40684.59315406808, 40725.59274407218, 41057.794711026254, 32420.83789581037, 36379.27241455209, 36433.81783091067, 36968.44547331846, 37482.00287953914, 27189.0, 27560.448791024468, 27708.0, 27744.0, 27870.3032424191], "value": 19469.870146852296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.5425238102373, 405.7038361995745, 407.41739312782715, 410.7473903549317, 432.33204698740445, 13012.544560940369, 17192.398266060674, 18583.72124418135, 19043.333483328086, 19050.04749762513, 14735.263236838142, 16528.173591320417, 17859.91070044651, 17929.10354482277, 18609.069546522653, 5311.601629877765, 5654.9151762723595, 5701.8311246194635, 5704.429557044283, 5708.914366284509, 5477.561795056406, 5582.0, 5658.830235092953, 5663.7168141592965, 5675.631083979549, 5617.775288988436, 5656.91514627281, 5658.8019419320335, 5663.377028526858, 5663.405342439026, 5477.452254774491, 5651.2935883014625, 5661.264035675356, 5662.065759149736, 5669.801556945507, 5078.923816142761, 5083.72039537829, 5088.211327244283, 5099.643024988252, 5114.411842638107, 21245.893770531202, 21823.23618673339, 21864.0, 22027.118915243373, 22397.104115835347, 2161.643328850738, 2302.4934514406973, 2545.083769842855, 2667.1692199348204, 2915.629654062587, 9910.801783964353, 9992.100710935978, 10323.84514232287, 10343.741406464824, 10432.061114499731, 1881.2192939930048, 1909.102721720789, 1923.7111135539221, 1942.155162504315, 1944.2903340280836, 70598.0, 74453.62773186153, 80608.59695701543, 80893.19106808916, 81896.59051704763, 10107.545160467796, 10112.898871011343, 10484.689413823273, 10826.458677066274, 11018.834717479243, 14052.578422647337, 14057.78913316301, 14065.789013164811, 14066.859331406555, 14074.366653500618, 6690.0968369270495, 7051.43588512928, 7068.681909314093, 7155.248698886646, 7554.773356799305, 6991.335823096798, 7086.114235720535, 7094.184168820651, 7198.352148306678, 7284.6721897514735, 4642.326862604971, 4705.976470117627, 4723.7401942893475, 4762.023138917991, 4860.198067318924, 1972.2308299763104, 1998.540335722792, 2015.4961259685078, 2016.8386529077638, 2028.198861449719, 843.3127001493763, 927.8422668146432, 1032.4579595712312, 1067.8558394616782, 1072.9141668666489, 18092.36676716335, 18274.0, 18315.63368732618, 18419.815801842076, 18743.906280468782, 929.2983797233046, 940.7648087978006, 955.3599088610648, 960.6253561111172, 983.2674657380297, 10094.14199793026, 10467.162626989822, 10467.267291289536, 10489.611508784465, 10551.419671918118, 417964.0, 427228.0, 432012.0, 432550.0, 433505.0, 80104.0, 85042.0, 87159.12840871637, 87306.12693873107, 87354.56322718346, 1006.854006169116, 1026.8408396698524, 1027.3579013116803, 1040.3497813866334, 1061.177587369779, 15885.920570397537, 16145.434909778101, 16149.111798851176, 16412.507624771275, 16469.83530164683, 39345.60654393534, 39761.0, 40173.0, 40197.79901100476, 40249.59750402458, 40538.59461405348, 41314.38028429636, 44389.0, 55733.442665572824, 56129.0, 6827.419669328163, 8098.959505202436, 8125.75622731319, 8430.704925327584, 8541.914580854113, 12005.339706316236, 12255.938720306342, 12348.259104453402, 12426.378681066091, 12842.486300548248, 10244.64143754965, 10678.359298442118, 10963.890361096606, 11045.723856903642, 11051.778964420828, 10090.293679442662, 10784.622538211124, 10972.835407468734, 10984.670459886216, 11034.889651103385, 10723.0, 10831.241813073324, 10973.177011723992, 11141.554337826396, 11329.886701132884, 8287.792805179677, 8291.41960062814, 8350.540720260444, 8646.610902509276, 8707.259882910024, 9678.564464598969, 10871.782564348827, 11093.11255099574, 11674.533018679498, 11850.466728997044], "value": 8782.059202880173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.4716728394137, 1470.6690994526232, 1593.6175317923694, 1730.0830559803308, 1740.8818074859919, 7328.120625524931, 7499.325060744532, 7982.52104873708, 8528.232459078681, 8533.91466085339, 7770.067591888967, 8073.838523229532, 8089.959550202241, 8092.433529652927, 8328.875066874001, 2190.1896298369625, 2236.1167338901123, 2269.205777977703, 2269.3305474884946, 2279.122537822942, 1932.053293886, 2229.041512149775, 2281.9201327953524, 2285.485765702712, 2288.0, 1939.6896496560553, 2115.598036373092, 2207.4922767763424, 2208.249195273607, 2221.80003799658, 2229.866208027507, 2241.5180736141806, 2245.191730976847, 2247.8538894971775, 2253.4479052632046, 2185.0276626901036, 2203.790639889208, 2209.9668504972437, 2214.6345852934246, 2215.9113635454564, 8046.959765201136, 8186.795330116735, 8200.343972482187, 8202.220789025092, 8202.482540729925, 4862.051899879525, 4958.3306253655655, 5019.121653710623, 5022.874428139289, 5026.371703537058, 3118.672539383355, 3188.7289580385695, 3346.7991920484606, 3364.52896594477, 3372.5615669962995, 1083.3012706804145, 1106.5186643809968, 1107.617871834216, 1112.4326593437324, 1150.0741902768268, 10962.0, 11214.27107238035, 11268.09855211581, 11346.659600212008, 11359.659210223625, 4214.7471151731, 4383.211022016068, 4435.046465010038, 4521.231390663595, 4546.727196368229, 9759.707208783748, 9770.413775173512, 9771.12059914611, 9775.31572789912, 9782.315237933419, 5046.899062018739, 5047.192449208109, 5047.2429135629945, 5049.293098966147, 5053.418856831438, 4516.119356725407, 4610.354550362952, 4668.066386722669, 4670.859874203779, 4674.345591617176, 3802.125511132455, 3821.2548553032448, 3831.578526362098, 3909.9413508797393, 3976.920461590752, 1232.9260244385366, 1240.8821161989597, 1241.1746188784539, 1247.376311844078, 1267.8478582569967, 748.3788455581854, 795.8806179073185, 823.2048318544503, 846.8645016797406, 917.5366439947784, 5238.76425560843, 5276.683398996072, 5301.946980530145, 5334.493223143795, 5446.7276636168035, 875.0593112404191, 897.2597606974273, 899.4962820820231, 903.8689390038408, 945.7068308824287, 3577.141486043331, 3591.8742844000335, 3595.8921232363073, 3629.909252268714, 3667.908302292464, 9951.353162044445, 10333.070023697903, 10348.327358721659, 10359.63741269067, 10389.220808439397, 10272.0, 10286.0, 10300.0, 10308.690739277683, 10319.84520232197, 7298.23368546295, 7668.884966725504, 7679.308862202429, 7817.296443320129, 7835.0, 5173.767180476812, 5357.464253574612, 5361.222622719762, 5445.50990410865, 5497.45025497447, 9306.627734890528, 9410.106039926197, 9413.81172376535, 9476.57355418994, 9477.289203309641, 9048.321375896965, 9545.0, 9635.181009614262, 9669.854952175583, 9758.121769040821, 7098.6450677466955, 7496.100467943882, 7496.437767167593, 7502.287282708134, 7505.0, 7887.566183859943, 7900.446968712135, 7942.404319675932, 7955.5624440654, 8071.313938315309, 7361.374283185989, 7372.152202496782, 7377.5204611700065, 7386.778396648109, 7425.183229844821, 7119.012306486542, 7220.097487814023, 7270.781876543712, 7293.52592081513, 7310.744123955636, 6306.810795676137, 6396.584222025554, 6398.360163983564, 6401.29585745577, 6404.455621272058, 4715.905681886412, 4755.358026666356, 4765.76171191446, 4781.13939490895, 4807.158747219292, 4744.620430365631, 4797.712137271775, 4876.927076043265, 4885.975570122127, 5050.065737838511], "value": 4370.606669023292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.40835371026503, 318.2203601177116, 322.62736539297106, 322.6869936161923, 324.28980532633545, 4664.603508701764, 4884.511548845123, 5024.7738851751665, 5083.262926875605, 5090.160123579614, 4998.800047998076, 5062.620568332887, 5087.6184286178595, 5099.541041306282, 5104.770285337159, 4015.4980627421573, 4016.3975403689387, 4016.7188296819236, 4018.236535058344, 4037.3338399164104, 3895.454636350899, 4056.736312139716, 4059.4316795648633, 4066.166435880652, 4073.9388909166387, 3798.2973149967206, 3980.8805735827973, 3984.9278375244853, 3996.7601943883315, 4007.5591684914634, 3951.9802400988096, 3954.4463775071513, 3965.9291991162227, 3973.7615743055508, 3976.880693579197, 3494.860205591773, 3502.8598856045983, 3512.5082488451635, 3512.5082488451635, 3514.6309637487952, 4765.7140571565815, 4879.463259041502, 4918.803247870081, 4940.382452193476, 4941.20940649498, 4538.591526762574, 4552.226121559343, 4557.225271703785, 4559.224931761609, 4561.315802629632, 5264.210368444726, 5266.499682530153, 5280.973595132038, 5316.0, 5326.733663316819, 3819.4080964273576, 3844.9231015379814, 3874.2057878134915, 3893.532776066862, 3896.5908579599018, 5119.2321151827155, 5274.314339135926, 5382.865428364283, 5391.299131112969, 5423.945760542383, 3864.091938394475, 3961.504811898513, 3962.920741585152, 3965.2862484753023, 3967.441000554626, 3993.880183594497, 4000.319945609195, 4004.2191772604647, 4005.218982298482, 4013.678905687538, 4516.864494065183, 4522.841700540531, 4524.954750452519, 4531.252343363308, 4539.477960034638, 5085.669431486942, 5293.761780719877, 5361.900810333872, 5367.1680889462195, 5423.674579525241, 1354.552997510819, 1369.965675914698, 1370.8080868678394, 1371.0745246958263, 1371.2184055088703, 832.7543374704477, 877.3814460805118, 880.9207171354609, 889.4885440871525, 891.8806897343792, 4545.840895568639, 4550.931736023962, 4557.453105627346, 4576.908461830745, 4591.931121033187, 4771.308160316735, 4780.44635493466, 4790.113828941657, 4824.710517368969, 4831.758412079382, 4399.84407640254, 4552.658550608651, 4557.908841823145, 4566.520515345841, 4580.305287043815, 2506.398464368575, 2542.6142752200094, 2548.241713217874, 2557.514072326252, 2573.3695244664805, 4872.366592342973, 4909.70541767488, 4925.261210818334, 4961.925571116436, 4975.651704380659, 4606.95393046072, 4861.683990540603, 4903.26451032348, 4906.828261010847, 4906.877328066756, 4886.780094895738, 4936.136176169156, 4936.506349365035, 4939.456659767351, 4950.935548856941, 4776.0, 4789.61683065347, 4803.303520989507, 4820.783064762024, 4876.780544875418, 4502.4371953505815, 4773.641976851681, 4782.832600859092, 4793.544613261734, 4806.7836947338155, 4860.902781944412, 4903.754812259444, 5296.814611488733, 5448.700321482356, 5463.836084917459, 3756.812159392074, 3759.9436008459347, 3789.5452545694693, 3811.1805961718364, 3816.2939856126704, 5383.16560933056, 5417.0, 5418.295621569171, 5431.511163995259, 5438.211459338295, 5133.75167594559, 5272.6836389816735, 5279.841604751864, 5288.920666189933, 5291.365036195527, 5264.447233040476, 5278.366596008504, 5288.576913846806, 5304.814331498379, 5313.335833020872, 5278.3637072507645, 5290.576753859759, 5293.761780719954, 5297.205419187153, 5307.6284660073425, 5157.329547158845, 5247.842564722911, 5264.289320941777, 5274.86812829667, 5277.815276465305, 5148.897022059463, 5189.76646050921, 5204.843854684214, 5229.869253268546, 5231.29377534028], "value": 3919.3757652138306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.5263434437564, 787.9960600196998, 827.0, 830.4643504939311, 848.1094850407075, 16194.271257793398, 17087.14564271788, 17107.0, 17113.65772684547, 17129.229184686686, 14876.0, 15041.323140458679, 15088.924555377234, 15098.396064157421, 15100.773488397655, 656.1175219329994, 792.0693185507021, 804.0512195609178, 804.6017221475378, 805.5931754464017, 655.6983787457775, 792.4017366887991, 794.5550491724653, 799.5282783157936, 815.3273549321804, 856.648774002659, 860.4837097741367, 861.3453775130914, 862.211076864668, 863.1497974495118, 695.2213520856623, 850.3664769746548, 851.7572491839858, 851.9659213631447, 852.4246133859651, 520.1573451009351, 605.7001784116846, 606.2421972534332, 611.6727550760322, 622.396275612655, 15058.924705376512, 15078.623034424227, 15116.244187790677, 15118.0, 15121.16833574153, 13797.172169669851, 14265.928670356685, 14479.05886117399, 14550.0, 14765.261736913219, 11740.941295293469, 12376.0, 12759.234445933274, 13392.531261405804, 13467.326633668277, 4369.781510924441, 4377.212101821671, 4462.2191116554795, 4463.24124898768, 4579.576597688391, 79133.60433197797, 80172.0, 80486.0, 81308.59345703293, 81435.59282203669, 11384.373859437645, 11639.301641901344, 11692.356920369291, 11973.940130299292, 12015.639530814089, 21691.457713557287, 21775.346739597837, 21872.562548749254, 21909.780902191094, 21998.45003874916, 8377.0, 8399.95800020996, 8403.495790252604, 8492.150784921581, 8695.13048695138, 4533.38799262102, 4651.488336283074, 4671.299305104261, 4675.906481870344, 4704.811807527729, 3294.0, 3366.9326613467592, 3405.965940340565, 3406.608240052376, 3409.079548521885, 653.3433898931544, 683.7504310926475, 693.237438817297, 702.2240424331143, 706.1279320039747, 734.6033142103312, 765.3226894198674, 776.6932061835544, 778.307306497218, 810.5177419435427, 9300.90699093014, 10263.589456421809, 10357.430341331148, 10376.533056012497, 10462.790744185073, 642.9710663020176, 684.4592771710293, 738.2838646512874, 747.2564798025999, 753.4048101999359, 4767.69010014348, 4901.828436004723, 4918.360613120271, 4958.157113290749, 4959.156943319645, 71634.64182679054, 79882.60058699669, 120157.39921300512, 133170.33414832863, 133485.33257333652, 84403.5779821097, 84552.15447845566, 85870.57064714636, 97662.5116874411, 111847.0, 52568.737156313975, 52603.94792104136, 81209.18790812134, 82273.58863205646, 84067.57966210252, 9332.813343733224, 9698.818299168208, 9779.476536721573, 9813.473207652603, 9830.954207218112, 44366.0, 45865.54134458613, 47715.0, 48003.75998119987, 49304.506954929995, 64086.0, 71796.28203718105, 72213.638931805, 74851.2514874866, 75444.0, 12741.235525868478, 12984.220946743226, 13242.668933276746, 13312.936494842927, 13783.104098233583, 13935.930320348334, 14989.250537473301, 15005.174715390758, 15284.15937123469, 15421.151836649093, 13573.59279221625, 13662.0, 13855.861441385458, 14077.718445631235, 14676.486322978644, 12988.285644289277, 13441.59675209706, 13482.460701571827, 13768.24274664903, 14050.297485125908, 13111.2133272004, 13219.801702974655, 13614.0, 13844.584662460142, 13958.511452099128, 10436.0, 10526.842097368393, 10815.837762433412, 11168.776624467628, 11415.828762568402, 10053.648122315684, 10168.631042446468, 10885.183611229031, 11399.699224236887, 11880.405979701154], "value": 7575.495415923196, "unit": "score"}], "name": "dromaeo_css", "value": 6966.225342663385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 124.0, 171.0, 130.0, 127.0, 123.0, 126.0, 167.0, 121.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 162.0, 159.0, 163.0, 161.0, 161.0, 160.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 111.0, 75.0, 77.0, 76.0, 77.0, 101.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 84.0, 82.0, 82.0, 106.0, 83.0, 82.0, 119.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 50.0, 51.0, 52.0, 53.0, 51.0, 51.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 62.0, 61.0, 62.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 80.0, 79.0, 86.0, 79.0, 80.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 147.0, 136.0, 136.0, 138.0, 134.0, 136.0, 130.0, 164.0, 135.0], "value": 138.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 163.0, 164.0, 166.0, 162.0, 162.0, 170.0, 165.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 69.0, 66.0, 67.0, 66.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1504.2, "alertThreshold": 2.0}]} 00:46:39 INFO - Return code: 0 00:46:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:46:39 INFO - # TBPL SUCCESS # 00:46:39 INFO - Running post-action listener: _resource_record_post_action 00:46:39 INFO - [mozharness: 2016-10-05 07:46:39.105513Z] Finished run-tests step (success) 00:46:39 INFO - Running post-run listener: _resource_record_post_run 00:46:39 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 431120384; Read time: 1308; Write time: 418776 00:46:39 INFO - TinderboxPrint: CPU usage
13.1% 00:46:39 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 1,308 00:46:39 INFO - TinderboxPrint: I/O write bytes / time
431,120,384 / 418,776 00:46:39 INFO - TinderboxPrint: CPU idle
8,311.7 (86.9%) 00:46:39 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 00:46:39 INFO - TinderboxPrint: Swap in / out
0 / 0 00:46:39 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 81764352; Read time: 0; Write time: 80244 00:46:39 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 5615616; Write bytes: 349356032; Read time: 1176; Write time: 338532 00:46:39 INFO - Running post-run listener: _upload_blobber_files 00:46:39 INFO - Blob upload gear active. 00:46:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:46:39 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 00:46:39 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:46:39 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:46:40 INFO - (blobuploader) - INFO - Open directory for files ... 00:46:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:46:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:46:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:43 INFO - (blobuploader) - INFO - Done attempting. 00:46:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:46:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:46:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:43 INFO - (blobuploader) - INFO - Done attempting. 00:46:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:46:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:46:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:46:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:46:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:46:44 INFO - (blobuploader) - INFO - Done attempting. 00:46:44 INFO - (blobuploader) - INFO - Iteration through files over. 00:46:44 INFO - Return code: 0 00:46:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:46:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:46:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/56bfe83782569f6c68cab0393c7238016fcc9f0fbc4f165e21b32485254dfc2fd0b3f0f4defc14b75d38484aaaee1bf4b72a36dcfbeb936dd2af20e987e19b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfd7ac5cbb937337f4b701f04695ea7f6c062807c5c31835fe6723c2115d3f0d7cc6d7d73958d6b6b1cb2a2dfed534a110172a092b41586f0b6a0e77fb47f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3a2552f50e64b90b15981bd526b015bec447a591d225bcb9b49f32d29c9bca5cb021e1c1342ef955c2a875293989be9518cc843cab42eaaad5b685bbbb7ba3c"} 00:46:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:46:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:46:44 INFO - Contents: 00:46:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/56bfe83782569f6c68cab0393c7238016fcc9f0fbc4f165e21b32485254dfc2fd0b3f0f4defc14b75d38484aaaee1bf4b72a36dcfbeb936dd2af20e987e19b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfd7ac5cbb937337f4b701f04695ea7f6c062807c5c31835fe6723c2115d3f0d7cc6d7d73958d6b6b1cb2a2dfed534a110172a092b41586f0b6a0e77fb47f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3a2552f50e64b90b15981bd526b015bec447a591d225bcb9b49f32d29c9bca5cb021e1c1342ef955c2a875293989be9518cc843cab42eaaad5b685bbbb7ba3c"} 00:46:44 INFO - Running post-run listener: copy_logs_to_upload_dir 00:46:44 INFO - Copying logs to upload dir... 00:46:44 INFO - mkdir: /builds/slave/test/build/upload/logs 00:46:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.039164 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-10-05 00:46:44.589680) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 00:46:44.593576) ========= 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=32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/56bfe83782569f6c68cab0393c7238016fcc9f0fbc4f165e21b32485254dfc2fd0b3f0f4defc14b75d38484aaaee1bf4b72a36dcfbeb936dd2af20e987e19b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfd7ac5cbb937337f4b701f04695ea7f6c062807c5c31835fe6723c2115d3f0d7cc6d7d73958d6b6b1cb2a2dfed534a110172a092b41586f0b6a0e77fb47f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3a2552f50e64b90b15981bd526b015bec447a591d225bcb9b49f32d29c9bca5cb021e1c1342ef955c2a875293989be9518cc843cab42eaaad5b685bbbb7ba3c"} build_url:https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/QifPcq7bTjySAO3Akkf8EA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/56bfe83782569f6c68cab0393c7238016fcc9f0fbc4f165e21b32485254dfc2fd0b3f0f4defc14b75d38484aaaee1bf4b72a36dcfbeb936dd2af20e987e19b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/3dfd7ac5cbb937337f4b701f04695ea7f6c062807c5c31835fe6723c2115d3f0d7cc6d7d73958d6b6b1cb2a2dfed534a110172a092b41586f0b6a0e77fb47f41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f3a2552f50e64b90b15981bd526b015bec447a591d225bcb9b49f32d29c9bca5cb021e1c1342ef955c2a875293989be9518cc843cab42eaaad5b685bbbb7ba3c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-05 00:46:44.619525) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:46:44.619862) ========= 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=32c5991c409366f7fec8a718000001d2-1475650345.52298-834243248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004456 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-05 00:46:44.703319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 00:46:44.703675) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-05 00:46:44.704000) ========= ========= Total master_lag: 0.18 =========