builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-059 starttime: 1477313504.11 results: success (0) buildid: 20161024030205 builduid: 25896b81c02c43e39fb49284fea31552 revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.105402) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.105927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.106201) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.122464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.122768) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-24 05:51:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-10-24 05:51:46 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157035 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.293634) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.293924) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017941 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.343049) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.343396) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 215f9686117673a2c914ed207bc7da9bb8d741ad --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=3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-24 05:51:46,909 truncating revision to first 12 chars 2016-10-24 05:51:46,910 Setting DEBUG logging. 2016-10-24 05:51:46,910 attempt 1/10 2016-10-24 05:51:46,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/215f96861176?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-24 05:51:47,216 unpacking tar archive at: mozilla-central-215f96861176/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583438 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.940906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.941314) ========= script_repo_revision: 215f9686117673a2c914ed207bc7da9bb8d741ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.941837) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.942150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-24 05:51:44.951877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-10-24 05:51:44.952262) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:51:47 INFO - MultiFileLogger online at 20161024 05:51:47 in /builds/slave/test 05:51:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:51:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:51:47 INFO - {'append_to_log': False, 05:51:47 INFO - 'base_work_dir': '/builds/slave/test', 05:51:47 INFO - 'blob_upload_branch': 'Firefox', 05:51:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:51:47 INFO - 'branch': 'Firefox', 05:51:47 INFO - 'buildbot_json_path': 'buildprops.json', 05:51:47 INFO - 'config_files': ('talos/linux_config.py',), 05:51:47 INFO - 'default_actions': ('clobber', 05:51:47 INFO - 'read-buildbot-config', 05:51:47 INFO - 'download-and-extract', 05:51:47 INFO - 'populate-webroot', 05:51:47 INFO - 'create-virtualenv', 05:51:47 INFO - 'install', 05:51:47 INFO - 'run-tests'), 05:51:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:51:47 INFO - 'download_minidump_stackwalk': True, 05:51:47 INFO - 'download_symbols': 'ondemand', 05:51:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:51:47 INFO - 'tooltool.py': '/tools/tooltool.py', 05:51:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:51:47 INFO - '/tools/misc-python/virtualenv.py')}, 05:51:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:51:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:51:47 INFO - 'installer_path': 'installer.exe', 05:51:47 INFO - 'log_level': 'info', 05:51:47 INFO - 'log_name': 'talos', 05:51:47 INFO - 'log_to_console': True, 05:51:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:51:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:51:47 INFO - 'opt_config_files': (), 05:51:47 INFO - 'pip_index': False, 05:51:47 INFO - 'sps_profile': False, 05:51:47 INFO - 'sps_profile_interval': 0, 05:51:47 INFO - 'suite': 'dromaeojs', 05:51:47 INFO - 'system_bits': '32', 05:51:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:51:47 INFO - 'title': 'talos-linux64-ix-059', 05:51:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:51:47 INFO - 'use_talos_json': True, 05:51:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:51:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:51:47 INFO - 'work_dir': 'build'} 05:51:47 INFO - [mozharness: 2016-10-24 12:51:47.620853Z] Running clobber step. 05:51:47 INFO - Running pre-action listener: _resource_record_pre_action 05:51:47 INFO - Running main action method: clobber 05:51:47 INFO - rmtree: /builds/slave/test/build 05:51:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:51:48 INFO - Running post-action listener: _resource_record_post_action 05:51:48 INFO - [mozharness: 2016-10-24 12:51:48.073871Z] Finished clobber step (success) 05:51:48 INFO - [mozharness: 2016-10-24 12:51:48.073972Z] Running read-buildbot-config step. 05:51:48 INFO - Running pre-action listener: _resource_record_pre_action 05:51:48 INFO - Running main action method: read_buildbot_config 05:51:48 INFO - Using buildbot properties: 05:51:48 INFO - { 05:51:48 INFO - "project": "", 05:51:48 INFO - "product": "firefox", 05:51:48 INFO - "script_repo_revision": "production", 05:51:48 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:51:48 INFO - "repository": "", 05:51:48 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:51:48 INFO - "buildid": "20161024030205", 05:51:48 INFO - "stage_platform": "linux64-pgo", 05:51:48 INFO - "basedir": "/builds/slave/test", 05:51:48 INFO - "nightly_build": "True", 05:51:48 INFO - "buildnumber": 28, 05:51:48 INFO - "slavename": "talos-linux64-ix-059", 05:51:48 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:51:48 INFO - "platform": "ubuntu64_hw", 05:51:48 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:51:48 INFO - "branch": "mozilla-central", 05:51:48 INFO - "repo_path": "mozilla-central", 05:51:48 INFO - "revision": "215f9686117673a2c914ed207bc7da9bb8d741ad", 05:51:48 INFO - "pgo_build": "True", 05:51:48 INFO - "builduid": "25896b81c02c43e39fb49284fea31552", 05:51:48 INFO - "slavebuilddir": "test" 05:51:48 INFO - } 05:51:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:51:48 INFO - Running post-action listener: _resource_record_post_action 05:51:48 INFO - [mozharness: 2016-10-24 12:51:48.076470Z] Finished read-buildbot-config step (success) 05:51:48 INFO - [mozharness: 2016-10-24 12:51:48.076559Z] Running download-and-extract step. 05:51:48 INFO - Running pre-action listener: _resource_record_pre_action 05:51:48 INFO - Running main action method: download_and_extract 05:51:48 INFO - mkdir: /builds/slave/test/build/tests 05:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:51:48 INFO - trying https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:51:48 INFO - Downloading https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/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 05:51:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/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 05:51:48 INFO - Downloaded 1361 bytes. 05:51:48 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:51:48 INFO - Using the following test package requirements: 05:51:48 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:48 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:51:48 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:51:48 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'jsshell-linux-x86_64.zip'], 05:51:48 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:51:48 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:51:48 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:51:48 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:51:48 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:51:48 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:51:48 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:51:48 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:51:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:51:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:51:48 INFO - Fetch https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:51:49 INFO - Http code: 200 05:51:49 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 05:51:49 INFO - x-amz-cf-id: lhegFhLFsvMRDKjPsdgTHlENqXjGFOIQVp4J7b6zwOXQY-14sBhIgw== 05:51:49 INFO - x-amz-version-id: 8Lxlrv3zWs5gwWvRuT_ttJRsXSR_YoIq 05:51:50 INFO - Expected file size: 22021822 05:51:50 INFO - Obtained file size: 22021822 05:51:54 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 05:51:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:51:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:51:54 INFO - Fetch https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:51:54 INFO - Http code: 200 05:51:54 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 05:51:54 INFO - x-amz-cf-id: xVJ8UW0Y0FzQuOnj0A_gHlmSjPz_8CEW6jVPSC_dFCNJv2neFWsTjg== 05:51:54 INFO - x-amz-version-id: 8Lxlrv3zWs5gwWvRuT_ttJRsXSR_YoIq 05:51:55 INFO - Expected file size: 22021822 05:51:55 INFO - Obtained file size: 22021822 05:51:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:51:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:51:59 INFO - Fetch https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:52:00 INFO - Http code: 200 05:52:00 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 05:52:00 INFO - x-amz-cf-id: X0Br1Z1UXOzB3yiiBn3K6FOiaZdiln7EnG23dQm0Ed8Hh0kLrR2qjg== 05:52:00 INFO - x-amz-version-id: Dduga8DKupsS3q6gGJ6DsvNrY20KjXUQ 05:52:01 INFO - Expected file size: 14409028 05:52:01 INFO - Obtained file size: 14409028 05:52: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')]} 05:52:01 INFO - trying https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:52:01 INFO - Downloading https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/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 05:52:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/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 05:53:02 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 05:53:02 INFO - retry: attempt #1 caught exception: The read operation timed out 05:53:02 INFO - retry: Failed, sleeping 30 seconds before retrying 05:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/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 #2 05:53:35 INFO - Downloaded 59371827 bytes. 05:53:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:53:35 INFO - mkdir: /builds/slave/test/properties 05:53:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:35 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:35 INFO - Contents: 05:53:35 INFO - build_url:https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:53:35 INFO - Running post-action listener: _resource_record_post_action 05:53:35 INFO - Running post-action listener: set_extra_try_arguments 05:53:35 INFO - [mozharness: 2016-10-24 12:53:35.858318Z] Finished download-and-extract step (success) 05:53:35 INFO - [mozharness: 2016-10-24 12:53:35.858549Z] Running populate-webroot step. 05:53:35 INFO - Running pre-action listener: _resource_record_pre_action 05:53:35 INFO - Running main action method: populate_webroot 05:53:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:35 INFO - '--tppagecycles', 05:53:35 INFO - '7'], 05:53:35 INFO - 'tests': ['tsvgm']}}, 05:53:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['damp', 'tps']}, 05:53:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'tests': ['damp', 'tps']}, 05:53:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['dromaeo_dom']}, 05:53:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['basic_compositor_video']}, 05:53:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['a11yr', 05:53:35 INFO - 'ts_paint', 05:53:35 INFO - 'tpaint', 05:53:35 INFO - 'sessionrestore', 05:53:35 INFO - 'sessionrestore_no_auto_restore', 05:53:35 INFO - 'tabpaint']}, 05:53:35 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:35 INFO - 'ts_paint', 05:53:35 INFO - 'tpaint', 05:53:35 INFO - 'sessionrestore', 05:53:35 INFO - 'sessionrestore_no_auto_restore', 05:53:35 INFO - 'tabpaint']}, 05:53:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:35 INFO - 'ts_paint', 05:53:35 INFO - 'tpaint', 05:53:35 INFO - 'sessionrestore', 05:53:35 INFO - 'sessionrestore_no_auto_restore', 05:53:35 INFO - 'tabpaint']}, 05:53:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:35 INFO - 'ts_paint', 05:53:35 INFO - 'tpaint', 05:53:35 INFO - 'sessionrestore', 05:53:35 INFO - 'sessionrestore_no_auto_restore', 05:53:35 INFO - 'tabpaint']}, 05:53:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['a11yr', 05:53:35 INFO - 'ts_paint', 05:53:35 INFO - 'tpaint', 05:53:35 INFO - 'sessionrestore', 05:53:35 INFO - 'sessionrestore_no_auto_restore', 05:53:35 INFO - 'tabpaint']}, 05:53:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['a11yr', 05:53:35 INFO - 'ts_paint', 05:53:35 INFO - 'tpaint', 05:53:35 INFO - 'sessionrestore', 05:53:35 INFO - 'sessionrestore_no_auto_restore', 05:53:35 INFO - 'tabpaint']}, 05:53:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['tsvgx', 05:53:35 INFO - 'tsvgr_opacity', 05:53:35 INFO - 'tart', 05:53:35 INFO - 'tscrollx', 05:53:35 INFO - 'cart']}, 05:53:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:35 INFO - 'tsvgr_opacity', 05:53:35 INFO - 'tart', 05:53:35 INFO - 'tscrollx', 05:53:35 INFO - 'cart']}, 05:53:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'talos_options': ['--disable-e10s'], 05:53:35 INFO - 'tests': ['tp5o']}, 05:53:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'tests': ['tp5o']}, 05:53:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'talos_options': ['--disable-e10s', 05:53:35 INFO - '--xperf_path', 05:53:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:35 INFO - 'tests': ['tp5n']}, 05:53:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:35 INFO - 'talos_options': ['--xperf_path', 05:53:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:35 INFO - 'tests': ['tp5n']}}, 05:53:35 INFO - 'talos.zip': {'path': '', 05:53:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:35 INFO - Running post-action listener: _resource_record_post_action 05:53:35 INFO - [mozharness: 2016-10-24 12:53:35.878634Z] Finished populate-webroot step (success) 05:53:35 INFO - [mozharness: 2016-10-24 12:53:35.878722Z] Running create-virtualenv step. 05:53:35 INFO - Running pre-action listener: _resource_record_pre_action 05:53:35 INFO - Running main action method: create_virtualenv 05:53:35 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:35 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 05:53:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:35 INFO - Using real prefix '/usr' 05:53:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:36 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:38 INFO - Installing pip.................done. 05:53:38 INFO - Return code: 0 05:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:53:38 INFO - Reading from file tmpfile_stdout 05:53:38 INFO - Output received: 05:53:38 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) 05:53:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:38 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')]} 05:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 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')]} 05:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:38 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 05:53:38 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 05:53:38 INFO - Using env: {'DISPLAY': ':0', 05:53:38 INFO - 'HOME': '/home/cltbld', 05:53:38 INFO - 'LANG': 'en_US.UTF-8', 05:53:38 INFO - 'LANGUAGE': 'en_US:en', 05:53:38 INFO - 'LOGNAME': 'cltbld', 05:53:38 INFO - 'MAIL': '/var/mail/cltbld', 05:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:38 INFO - 'MOZ_NO_REMOTE': '1', 05:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:38 INFO - 'NO_EM_RESTART': '1', 05:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:38 INFO - 'PWD': '/builds/slave/test', 05:53:38 INFO - 'SHELL': '/bin/bash', 05:53:38 INFO - 'SHLVL': '1', 05:53:38 INFO - 'TERM': 'linux', 05:53:38 INFO - 'TMOUT': '86400', 05:53:38 INFO - 'USER': 'cltbld', 05:53:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:38 INFO - '_': '/tools/buildbot/bin/python'} 05:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:38 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 05:53:38 INFO - Cleaning up... 05:53:38 INFO - Return code: 0 05:53:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:38 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')]} 05:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 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')]} 05:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:38 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:38 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 05:53:38 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 05:53:38 INFO - Using env: {'DISPLAY': ':0', 05:53:38 INFO - 'HOME': '/home/cltbld', 05:53:38 INFO - 'LANG': 'en_US.UTF-8', 05:53:38 INFO - 'LANGUAGE': 'en_US:en', 05:53:38 INFO - 'LOGNAME': 'cltbld', 05:53:38 INFO - 'MAIL': '/var/mail/cltbld', 05:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:38 INFO - 'MOZ_NO_REMOTE': '1', 05:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:38 INFO - 'NO_EM_RESTART': '1', 05:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:38 INFO - 'PWD': '/builds/slave/test', 05:53:38 INFO - 'SHELL': '/bin/bash', 05:53:38 INFO - 'SHLVL': '1', 05:53:38 INFO - 'TERM': 'linux', 05:53:38 INFO - 'TMOUT': '86400', 05:53:38 INFO - 'USER': 'cltbld', 05:53:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:38 INFO - '_': '/tools/buildbot/bin/python'} 05:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:39 INFO - Downloading/unpacking psutil>=3.1.1 05:53:39 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 05:53:39 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 05:53:39 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 05:53:39 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 05:53:39 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 05:53:39 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 05:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:41 INFO - Installing collected packages: psutil 05:53:41 INFO - Running setup.py install for psutil 05:53:41 INFO - building 'psutil._psutil_linux' extension 05:53:41 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 05:53:41 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 05:53:41 INFO - building 'psutil._psutil_posix' extension 05:53:41 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 05:53:41 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 05:53:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:41 INFO - Successfully installed psutil 05:53:41 INFO - Cleaning up... 05:53:41 INFO - Return code: 0 05:53:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53:41 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')]} 05:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:41 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')]} 05:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:41 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:41 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 05:53:41 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 05:53:41 INFO - Using env: {'DISPLAY': ':0', 05:53:41 INFO - 'HOME': '/home/cltbld', 05:53:41 INFO - 'LANG': 'en_US.UTF-8', 05:53:41 INFO - 'LANGUAGE': 'en_US:en', 05:53:41 INFO - 'LOGNAME': 'cltbld', 05:53:41 INFO - 'MAIL': '/var/mail/cltbld', 05:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:41 INFO - 'MOZ_NO_REMOTE': '1', 05:53:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:41 INFO - 'NO_EM_RESTART': '1', 05:53:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:41 INFO - 'PWD': '/builds/slave/test', 05:53:41 INFO - 'SHELL': '/bin/bash', 05:53:41 INFO - 'SHLVL': '1', 05:53:41 INFO - 'TERM': 'linux', 05:53:41 INFO - 'TMOUT': '86400', 05:53:41 INFO - 'USER': 'cltbld', 05:53:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:41 INFO - '_': '/tools/buildbot/bin/python'} 05:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:41 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 05:53:41 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 05:53:41 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 05:53:41 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 05:53:41 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 05:53:41 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 05:53:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:43 INFO - Installing collected packages: mozsystemmonitor 05:53:43 INFO - Running setup.py install for mozsystemmonitor 05:53:44 INFO - Successfully installed mozsystemmonitor 05:53:44 INFO - Cleaning up... 05:53:44 INFO - Return code: 0 05:53:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53:44 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')]} 05:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:44 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')]} 05:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:44 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:44 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 05:53:44 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 05:53:44 INFO - Using env: {'DISPLAY': ':0', 05:53:44 INFO - 'HOME': '/home/cltbld', 05:53:44 INFO - 'LANG': 'en_US.UTF-8', 05:53:44 INFO - 'LANGUAGE': 'en_US:en', 05:53:44 INFO - 'LOGNAME': 'cltbld', 05:53:44 INFO - 'MAIL': '/var/mail/cltbld', 05:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:44 INFO - 'MOZ_NO_REMOTE': '1', 05:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:44 INFO - 'NO_EM_RESTART': '1', 05:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:44 INFO - 'PWD': '/builds/slave/test', 05:53:44 INFO - 'SHELL': '/bin/bash', 05:53:44 INFO - 'SHLVL': '1', 05:53:44 INFO - 'TERM': 'linux', 05:53:44 INFO - 'TMOUT': '86400', 05:53:44 INFO - 'USER': 'cltbld', 05:53:44 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:44 INFO - '_': '/tools/buildbot/bin/python'} 05:53:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:44 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:44 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 05:53:44 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 05:53:44 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 05:53:44 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 05:53:44 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 05:53:44 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 05:53:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:46 INFO - warning: no files found matching '*.txt' 05:53:46 INFO - no previously-included directories found matching 'build' 05:53:46 INFO - no previously-included directories found matching 'dist' 05:53:46 INFO - no previously-included directories found matching '.git*' 05:53:46 INFO - Installing collected packages: jsonschema, functools32 05:53:46 INFO - Running setup.py install for functools32 05:53:46 INFO - warning: no files found matching '*.txt' 05:53:46 INFO - no previously-included directories found matching 'build' 05:53:46 INFO - no previously-included directories found matching 'dist' 05:53:46 INFO - no previously-included directories found matching '.git*' 05:53:46 INFO - Successfully installed jsonschema functools32 05:53:46 INFO - Cleaning up... 05:53:46 INFO - Return code: 0 05:53:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:53:46 INFO - Using env: {'DISPLAY': ':0', 05:53:46 INFO - 'HOME': '/home/cltbld', 05:53:46 INFO - 'LANG': 'en_US.UTF-8', 05:53:46 INFO - 'LANGUAGE': 'en_US:en', 05:53:46 INFO - 'LOGNAME': 'cltbld', 05:53:46 INFO - 'MAIL': '/var/mail/cltbld', 05:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:46 INFO - 'MOZ_NO_REMOTE': '1', 05:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:46 INFO - 'NO_EM_RESTART': '1', 05:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:46 INFO - 'PWD': '/builds/slave/test', 05:53:46 INFO - 'SHELL': '/bin/bash', 05:53:46 INFO - 'SHLVL': '1', 05:53:46 INFO - 'TERM': 'linux', 05:53:46 INFO - 'TMOUT': '86400', 05:53:46 INFO - 'USER': 'cltbld', 05:53:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:46 INFO - '_': '/tools/buildbot/bin/python'} 05:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:47 INFO - Cleaning up... 05:53:47 INFO - Return code: 0 05:53:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:47 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')]} 05:53:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:47 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')]} 05:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:47 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:47 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 05:53:47 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 05:53:47 INFO - Using env: {'DISPLAY': ':0', 05:53:47 INFO - 'HOME': '/home/cltbld', 05:53:47 INFO - 'LANG': 'en_US.UTF-8', 05:53:47 INFO - 'LANGUAGE': 'en_US:en', 05:53:47 INFO - 'LOGNAME': 'cltbld', 05:53:47 INFO - 'MAIL': '/var/mail/cltbld', 05:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:47 INFO - 'MOZ_NO_REMOTE': '1', 05:53:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:47 INFO - 'NO_EM_RESTART': '1', 05:53:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:47 INFO - 'PWD': '/builds/slave/test', 05:53:47 INFO - 'SHELL': '/bin/bash', 05:53:47 INFO - 'SHLVL': '1', 05:53:47 INFO - 'TERM': 'linux', 05:53:47 INFO - 'TMOUT': '86400', 05:53:47 INFO - 'USER': 'cltbld', 05:53:47 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:47 INFO - '_': '/tools/buildbot/bin/python'} 05:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:47 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:47 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 05:53:47 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 05:53:47 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 05:53:47 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 05:53:47 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 05:53:47 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 05:53:49 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:50 INFO - Downloading docopt-0.6.1.tar.gz 05:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:50 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:50 INFO - Running setup.py install for blobuploader 05:53:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:50 INFO - Running setup.py install for requests 05:53:50 INFO - Running setup.py install for docopt 05:53:50 INFO - Successfully installed blobuploader requests docopt 05:53:50 INFO - Cleaning up... 05:53:50 INFO - Return code: 0 05:53:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:50 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')]} 05:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:50 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')]} 05:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:50 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:50 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 05:53:50 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 05:53:50 INFO - Using env: {'DISPLAY': ':0', 05:53:50 INFO - 'HOME': '/home/cltbld', 05:53:50 INFO - 'LANG': 'en_US.UTF-8', 05:53:50 INFO - 'LANGUAGE': 'en_US:en', 05:53:50 INFO - 'LOGNAME': 'cltbld', 05:53:50 INFO - 'MAIL': '/var/mail/cltbld', 05:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:50 INFO - 'MOZ_NO_REMOTE': '1', 05:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:50 INFO - 'NO_EM_RESTART': '1', 05:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:50 INFO - 'PWD': '/builds/slave/test', 05:53:50 INFO - 'SHELL': '/bin/bash', 05:53:50 INFO - 'SHLVL': '1', 05:53:50 INFO - 'TERM': 'linux', 05:53:50 INFO - 'TMOUT': '86400', 05:53:50 INFO - 'USER': 'cltbld', 05:53:50 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:50 INFO - '_': '/tools/buildbot/bin/python'} 05:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:50 INFO - Running setup.py (path:/tmp/pip-tRv932-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:50 INFO - Running setup.py (path:/tmp/pip-8rtpxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:51 INFO - Running setup.py (path:/tmp/pip-MKh4N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:51 INFO - Running setup.py (path:/tmp/pip-2JBr3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:51 INFO - Running setup.py (path:/tmp/pip-sa7MH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:51 INFO - Running setup.py (path:/tmp/pip-047iE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:51 INFO - Running setup.py (path:/tmp/pip-SqCPij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:51 INFO - Running setup.py (path:/tmp/pip-owgWQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:51 INFO - Running setup.py (path:/tmp/pip-FvBbBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:51 INFO - Running setup.py (path:/tmp/pip-5VO5ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:51 INFO - Running setup.py (path:/tmp/pip-5FQGmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:51 INFO - Running setup.py (path:/tmp/pip-k0YEz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:51 INFO - Running setup.py (path:/tmp/pip-RRCfze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:51 INFO - Running setup.py (path:/tmp/pip-XjymiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:51 INFO - Running setup.py (path:/tmp/pip-CRtrTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:52 INFO - Running setup.py (path:/tmp/pip-rbe2hC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:52 INFO - Running setup.py (path:/tmp/pip-P4GT50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:52 INFO - Running setup.py install for manifestparser 05:53:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Running setup.py install for mozcrash 05:53:52 INFO - Running setup.py install for mozdebug 05:53:52 INFO - Running setup.py install for mozdevice 05:53:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Running setup.py install for mozfile 05:53:52 INFO - Running setup.py install for mozhttpd 05:53:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Running setup.py install for mozinfo 05:53:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Running setup.py install for mozInstall 05:53:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:52 INFO - Running setup.py install for mozleak 05:53:53 INFO - Running setup.py install for mozlog 05:53:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Running setup.py install for moznetwork 05:53:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Running setup.py install for mozprocess 05:53:53 INFO - Running setup.py install for mozprofile 05:53:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Running setup.py install for mozrunner 05:53:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Running setup.py install for mozscreenshot 05:53:53 INFO - Running setup.py install for moztest 05:53:53 INFO - Running setup.py install for mozversion 05:53:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:53 INFO - Cleaning up... 05:53:53 INFO - Return code: 0 05:53:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:53 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:53 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 05:53:53 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 05:53:53 INFO - Using env: {'DISPLAY': ':0', 05:53:53 INFO - 'HOME': '/home/cltbld', 05:53:53 INFO - 'LANG': 'en_US.UTF-8', 05:53:53 INFO - 'LANGUAGE': 'en_US:en', 05:53:53 INFO - 'LOGNAME': 'cltbld', 05:53:53 INFO - 'MAIL': '/var/mail/cltbld', 05:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:53 INFO - 'MOZ_NO_REMOTE': '1', 05:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:53 INFO - 'NO_EM_RESTART': '1', 05:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:53 INFO - 'PWD': '/builds/slave/test', 05:53:53 INFO - 'SHELL': '/bin/bash', 05:53:53 INFO - 'SHLVL': '1', 05:53:53 INFO - 'TERM': 'linux', 05:53:53 INFO - 'TMOUT': '86400', 05:53:53 INFO - 'USER': 'cltbld', 05:53:53 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:53 INFO - '_': '/tools/buildbot/bin/python'} 05:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:54 INFO - Running setup.py (path:/tmp/pip-Uff3E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:54 INFO - Running setup.py (path:/tmp/pip-VZD8LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:54 INFO - Running setup.py (path:/tmp/pip-79TkS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:54 INFO - Running setup.py (path:/tmp/pip-WmwOPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:54 INFO - Running setup.py (path:/tmp/pip-Idr0T8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:54 INFO - Running setup.py (path:/tmp/pip-u3YfWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:54 INFO - Running setup.py (path:/tmp/pip-yq1KTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:54 INFO - Running setup.py (path:/tmp/pip-KM31uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:54 INFO - Running setup.py (path:/tmp/pip-fFDqx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:54 INFO - Running setup.py (path:/tmp/pip-vw6jmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:54 INFO - Running setup.py (path:/tmp/pip-k23nQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:54 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)) 05:53:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:55 INFO - Running setup.py (path:/tmp/pip-JwGnVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:55 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)) 05:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:55 INFO - Running setup.py (path:/tmp/pip-Wd0k8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:55 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)) 05:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:55 INFO - Running setup.py (path:/tmp/pip-aQp7H2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:55 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)) 05:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:55 INFO - Running setup.py (path:/tmp/pip-Y3xzps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:55 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)) 05:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:55 INFO - Running setup.py (path:/tmp/pip-V5cWHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:55 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)) 05:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:55 INFO - Running setup.py (path:/tmp/pip-mx6fWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:55 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)) 05:53:55 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)) 05:53:55 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)) 05:53:55 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)) 05:53:55 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)) 05:53:55 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)) 05:53:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:55 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 05:53:55 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 05:53:55 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 05:53:55 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 05:53:55 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 05:53:55 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 05:53:57 INFO - Downloading blessings-1.6.tar.gz 05:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:57 INFO - Installing collected packages: blessings 05:53:57 INFO - Running setup.py install for blessings 05:53:57 INFO - Successfully installed blessings 05:53:57 INFO - Cleaning up... 05:53:57 INFO - Return code: 0 05:53:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:57 INFO - Reading from file tmpfile_stdout 05:53:57 INFO - Current package versions: 05:53:57 INFO - argparse == 1.2.1 05:53:57 INFO - blessings == 1.6 05:53:57 INFO - blobuploader == 1.2.4 05:53:57 INFO - docopt == 0.6.1 05:53:57 INFO - functools32 == 3.2.3-2 05:53:57 INFO - jsonschema == 2.5.1 05:53:57 INFO - manifestparser == 1.1 05:53:57 INFO - mozInstall == 1.12 05:53:57 INFO - mozcrash == 0.17 05:53:57 INFO - mozdebug == 0.1 05:53:57 INFO - mozdevice == 0.48 05:53:57 INFO - mozfile == 1.2 05:53:57 INFO - mozhttpd == 0.7 05:53:57 INFO - mozinfo == 0.9 05:53:57 INFO - mozleak == 0.1 05:53:57 INFO - mozlog == 3.4 05:53:57 INFO - moznetwork == 0.27 05:53:57 INFO - mozprocess == 0.23 05:53:57 INFO - mozprofile == 0.28 05:53:57 INFO - mozrunner == 6.12 05:53:57 INFO - mozscreenshot == 0.1 05:53:57 INFO - mozsystemmonitor == 0.3 05:53:57 INFO - moztest == 0.7 05:53:57 INFO - mozversion == 1.4 05:53:57 INFO - psutil == 3.1.1 05:53:57 INFO - requests == 1.2.3 05:53:57 INFO - wsgiref == 0.1.2 05:53:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:57 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 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:57 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 05:53:57 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 05:53:57 INFO - Using env: {'DISPLAY': ':0', 05:53:57 INFO - 'HOME': '/home/cltbld', 05:53:57 INFO - 'LANG': 'en_US.UTF-8', 05:53:57 INFO - 'LANGUAGE': 'en_US:en', 05:53:57 INFO - 'LOGNAME': 'cltbld', 05:53:57 INFO - 'MAIL': '/var/mail/cltbld', 05:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:57 INFO - 'MOZ_NO_REMOTE': '1', 05:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:57 INFO - 'NO_EM_RESTART': '1', 05:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:57 INFO - 'PWD': '/builds/slave/test', 05:53:57 INFO - 'SHELL': '/bin/bash', 05:53:57 INFO - 'SHLVL': '1', 05:53:57 INFO - 'TERM': 'linux', 05:53:57 INFO - 'TMOUT': '86400', 05:53:57 INFO - 'USER': 'cltbld', 05:53:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:57 INFO - '_': '/tools/buildbot/bin/python'} 05:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 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)) 05:53:58 INFO - Cleaning up... 05:53:58 INFO - Return code: 0 05:53:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1d91ab1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23aa8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2477790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, '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': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', '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 05:53:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:53:58 INFO - Using env: {'DISPLAY': ':0', 05:53:58 INFO - 'HOME': '/home/cltbld', 05:53:58 INFO - 'LANG': 'en_US.UTF-8', 05:53:58 INFO - 'LANGUAGE': 'en_US:en', 05:53:58 INFO - 'LOGNAME': 'cltbld', 05:53:58 INFO - 'MAIL': '/var/mail/cltbld', 05:53:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:58 INFO - 'MOZ_NO_REMOTE': '1', 05:53:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:58 INFO - 'NO_EM_RESTART': '1', 05:53:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:58 INFO - 'PWD': '/builds/slave/test', 05:53:58 INFO - 'SHELL': '/bin/bash', 05:53:58 INFO - 'SHLVL': '1', 05:53:58 INFO - 'TERM': 'linux', 05:53:58 INFO - 'TMOUT': '86400', 05:53:58 INFO - 'USER': 'cltbld', 05:53:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:53:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:58 INFO - '_': '/tools/buildbot/bin/python'} 05:53:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:58 INFO - Cleaning up... 05:53:58 INFO - Return code: 0 05:53:58 INFO - Running post-action listener: _resource_record_post_action 05:53:58 INFO - Running post-action listener: _start_resource_monitoring 05:53:58 INFO - Starting resource monitoring. 05:53:58 INFO - [mozharness: 2016-10-24 12:53:58.318742Z] Finished create-virtualenv step (success) 05:53:58 INFO - [mozharness: 2016-10-24 12:53:58.319267Z] Running install step. 05:53:58 INFO - Running pre-action listener: _resource_record_pre_action 05:53:58 INFO - Running main action method: install 05:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:58 INFO - Reading from file tmpfile_stdout 05:53:58 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:58 INFO - Reading from file tmpfile_stdout 05:53:58 INFO - Output received: 05:53:58 INFO - Usage: mozinstall [options] installer 05:53:58 INFO - Options: 05:53:58 INFO - -h, --help show this help message and exit 05:53:58 INFO - -d DEST, --destination=DEST 05:53:58 INFO - Directory to install application into. [default: 05:53:58 INFO - "/builds/slave/test"] 05:53:58 INFO - --app=APP Application being installed. [default: firefox] 05:53:58 INFO - mkdir: /builds/slave/test/build/application 05:53:58 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'] 05:53:58 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 05:54:15 INFO - Reading from file tmpfile_stdout 05:54:15 INFO - Output received: 05:54:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:54:15 INFO - Running post-action listener: _resource_record_post_action 05:54:15 INFO - [mozharness: 2016-10-24 12:54:15.512927Z] Finished install step (success) 05:54:15 INFO - [mozharness: 2016-10-24 12:54:15.513175Z] Running run-tests step. 05:54:15 INFO - Running pre-action listener: _resource_record_pre_action 05:54:15 INFO - Running main action method: run_tests 05:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:54:15 INFO - Python 2.7.3 05:54:15 INFO - Return code: 0 05:54:15 INFO - grabbing minidump binary from tooltool 05:54:15 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')]} 05:54:15 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 0x2474930>, '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 0x2475830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2475cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:54:15 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 05:54:15 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 05:54:15 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 05:54:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:54:15 INFO - Return code: 0 05:54:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:54:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:54:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:54:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:54:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:54:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 05:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 05:54:15 INFO - Using env: {'DISPLAY': ':0', 05:54:15 INFO - 'HOME': '/home/cltbld', 05:54:15 INFO - 'LANG': 'en_US.UTF-8', 05:54:15 INFO - 'LANGUAGE': 'en_US:en', 05:54:15 INFO - 'LOGNAME': 'cltbld', 05:54:15 INFO - 'MAIL': '/var/mail/cltbld', 05:54:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:54:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:54:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:54:15 INFO - 'MOZ_NO_REMOTE': '1', 05:54:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:54:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:54:15 INFO - 'NO_EM_RESTART': '1', 05:54:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:54:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:54:15 INFO - 'PWD': '/builds/slave/test', 05:54:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:54:15 INFO - 'SHELL': '/bin/bash', 05:54:15 INFO - 'SHLVL': '1', 05:54:15 INFO - 'TERM': 'linux', 05:54:15 INFO - 'TMOUT': '86400', 05:54:15 INFO - 'USER': 'cltbld', 05:54:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034', 05:54:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:54:15 INFO - '_': '/tools/buildbot/bin/python'} 05:54:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 05:54:15 INFO - mozversion application_buildid: 20161024030205 05:54:15 INFO - mozversion application_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 05:54:15 INFO - mozversion application_display_name: Nightly 05:54:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:54:15 INFO - mozversion application_name: Firefox 05:54:15 INFO - mozversion application_remotingname: firefox 05:54:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:54:15 INFO - mozversion application_vendor: Mozilla 05:54:15 INFO - mozversion application_version: 52.0a1 05:54:15 INFO - mozversion platform_buildid: 20161024030205 05:54:15 INFO - mozversion platform_changeset: 215f9686117673a2c914ed207bc7da9bb8d741ad 05:54:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:54:15 INFO - mozversion platform_version: 52.0a1 05:54:15 INFO - using testdate: 1477313655 05:54:15 INFO - actual date: 1477313655 05:54:15 INFO - starting webserver on 'localhost:59714' 05:54:15 INFO - SUITE-START | Running 2 tests 05:54:15 INFO - TEST-START | dromaeo_css 05:54:15 INFO - operating with platform_type : linux_ 05:54:15 INFO - Initialising browser for dromaeo_css test... 05:54:15 INFO - TEST-INFO | started process 28491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZSyXA/profile http://localhost:59714/getInfo.html) 05:54:19 INFO - PROCESS | 28491 | __metrics Screen width/height:1600/1200 05:54:19 INFO - PROCESS | 28491 | colorDepth:24 05:54:19 INFO - PROCESS | 28491 | Browser inner width/height: 1024/697 05:54:19 INFO - PROCESS | 28491 | __metrics 05:54:20 INFO - PROCESS | 28491 | 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" 05:54:20 INFO - PROCESS | 28491 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:54:20 INFO - PROCESS | 28491 | console.error: PushService: 05:54:20 INFO - PROCESS | 28491 | stateChangeProcessEnqueue: Error transitioning state 05:54:20 INFO - PROCESS | 28491 | UnknownError 05:54:21 INFO - TEST-INFO | 28491: exit 0 05:54:21 INFO - Browser initialized. 05:54:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:54:21 INFO - TEST-INFO | started process 28573 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZSyXA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:33 INFO - PROCESS | 28573 | RSS: Main: 172269568 05:54:33 INFO - PROCESS | 28573 | 05:55:25 INFO - PROCESS | 28573 | 1477313725041 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] 05:57:36 INFO - PROCESS | 28573 | Cycle 1(1): loaded http://localhost:59714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59714/tests/dromaeo/cssquery-ext.html) 05:57:38 INFO - PROCESS | 28573 | RSS: Main: 296103936 05:57:38 INFO - PROCESS | 28573 | 06:00:40 INFO - PROCESS | 28573 | Cycle 1(1): loaded http://localhost:59714/tests/dromaeo/cssquery-ext.html (next: http://localhost:59714/tests/dromaeo/cssquery-jquery.html) 06:00:41 INFO - PROCESS | 28573 | RSS: Main: 284139520 06:00:41 INFO - PROCESS | 28573 | 06:03:43 INFO - PROCESS | 28573 | Cycle 1(1): loaded http://localhost:59714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59714/tests/dromaeo/cssquery-mootools.html) 06:03:43 INFO - PROCESS | 28573 | RSS: Main: 242343936 06:03:43 INFO - PROCESS | 28573 | 06:06:45 INFO - PROCESS | 28573 | Cycle 1(1): loaded http://localhost:59714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59714/tests/dromaeo/cssquery-prototype.html) 06:06:46 INFO - PROCESS | 28573 | RSS: Main: 217030656 06:06:46 INFO - PROCESS | 28573 | 06:09:49 INFO - PROCESS | 28573 | Cycle 1(1): loaded http://localhost:59714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59714/tests/dromaeo/cssquery-yui.html) 06:09:49 INFO - PROCESS | 28573 | RSS: Main: 216883200 06:09:49 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | Cycle 1(1): loaded http://localhost:59714/tests/dromaeo/cssquery-yui.html (next: http://localhost:59714/tests/dromaeo/cssquery-dojo.html) 06:12:53 INFO - PROCESS | 28573 | RSS: Main: 307187712 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | __start_tp_report 06:12:53 INFO - PROCESS | 28573 | _x_x_mozilla_page_load 06:12:53 INFO - PROCESS | 28573 | _x_x_mozilla_page_load_details 06:12:53 INFO - PROCESS | 28573 | |i|pagename|runs| 06:12:53 INFO - PROCESS | 28573 | |0;dojo.html;3097.179247499413;3117.3297740985686;3149.259923917879;3159.6682348353424;3163.240822202672;5176.482351764822;5246.5278124968745;5396.595255355849;5483.670979741219;5486.945130548694;5255.816046438375;5272.894542109156;5273.499017593323;5283.181106928422;5287.973560132204;4760.690555113923;4771.832985845496;4788.569028787409;4819.204831202865;4827.56551910328;4993.6005119590345;4995.750212489379;5032.748362581856;5033.320501732256;5033.748312584375;4865.5134486551415;4880.194767863316;4905.656604037718;4961.975190124044;5023.899522009558;4996.975015124937;5023.673461225008;5030.37120359955;5031.47169547196;5089.567386772129;4811.374521312207;4851.272309153655;4882.6826256293225;4926.729029903354;4940.357753492023;5298.947010529922;5305.973470132663;5318.042752304584;5340.06548853949;5397.352317721859;5639.15412688096;5694.032014557493;5694.088945768699;5695.914561281584;5698.6865722385255;5727.455891690282;5754.510866576346;5791.971040144815;5831.212786273841;5892.027815410452;5481.451854814566;5482.314710661168;5483.040467918098;5490.149026900797;5491.341039075336;5810.244668193192;5836.241288632451;5889.087191485327;5972.223610930638;5979.043353063489;5594.13290939905;5598.440155984369;5599.356074051455;5657.32112146545;5665.12190610456;5641.182028605911;5684.488396044293;5690.857728556819;5698.088305871041;5704.629199102045;5580.972095139579;5599.048161812501;5628.831135065954;5671.376148623648;5675.687837168913;5707.715763953161;5717.256756621696;5723.656580605177;5723.742431590588;5724.79963201286;4341.934870976938;4369.300911854151;4371.19132960397;4375.693701440932;4377.015171586368;3961.564227934925;3968.3849003404516;3969.3450580654444;3971;3972.1261322509004;5395.78416863321;5403.324584426947;5407.161889906992;5407.351117865803;5407.729613519308;5772.2207501986695;5792.391798861143;5798.985177593904;5822.534197264209;5824.825255242349;5474.863128421821;5475.534579560703;5476.397596264408;5478.506934375846;5535.059039963216;4960.429550601655;4974.751262436864;4983.377077865267;5000.774965126578;5032.370953630796;5720.799772007959;5771.942280577225;5781.595288329777;5876.382979787232;5983.431574000463;5768.769249229984;5807.593468457168;5854.970725146347;5865.090910908816;5876.588638795243;5956.22569066036;5957.255343082114;5957.970210148921;5964.9105263420215;5966;5563.638363506359;5597.524210442158;5660;5677.063284558167;5679.659220446786;5718.8570285741525;5723.885522289447;5728.283964504437;5760.395158508296;5824.446677565625;5630.831075067591;5633.971830140823;5639.295088113986;5641.238432811518;5642.097264437671;5542.750576223999;5550.473619754438;5573.693446860461;5576.832695019156;5586.748596313095;5389.137737961907;5490.835274941758;5631.6902570359025;5690.743916523849;5695.772169113355;5703.144528320785;5733.283339582552;5738.770449182153;5738.942610573841;5785.27684039495;5606.803761868315;5619.072852979212;5621.044422448112;5622.01614717431;5628.380878103487 06:12:53 INFO - PROCESS | 28573 | |1;ext.html;553.6346011632321;603.7977277612;614.2506142506144;638.511538672915;643.9921522816788;30650.54024189636;31529.527057094132;41805.58194418055;42963.35554966678;43022.13955720884;39973.200535989265;43353.78323108388;43429.34855977163;43437.78281108598;43456.782716086454;8664.826703465927;8803.33974951878;8807.64769409223;8822.73531794044;8824.558772061404;8008.599570021504;8199.79500512486;8665.220130188281;10289.845652315222;10538.947305263462;10699.164721348849;10726.517306721216;10750.462476876164;10763.677089687282;10769.569217231341;10608.946955265214;10664.306820056672;10693.037626613643;10694.411807350592;10700.892991070068;10400.739981500446;10466.581336746598;10475.057244847923;10482.109020733247;10488.68533943983;41412.79293603543;41816.1636767266;41821.581784182075;41907.37138942918;41919.161616767495;3369.1913940654313;3470.9652903471147;3872.961270387288;3995.360742281221;4055.472788537501;29731.70268297311;30618.38763224723;30745.692543074507;30873.691263087305;32548.83725581357;4014.3777714454013;4115.485564304462;4172.687048471377;4267.594578515036;4312.5903039211225;314002;314678;314742;315453;317889;55506.16740748892;55679.721601391735;55917.36537125074;55919.72040139855;56079.15881261785;57757;57764;58150.709246453494;58235.70882145562;58322;16060.072791264889;16299.266533006043;16307.836921630631;16314.347426102822;16314.918425408034;11192.664220073411;12154.331511766937;12166.148369614042;12168.209066410654;12188.268703877795;14254.643633909236;15662.650602409729;16079;16117.113558754381;16630.916845415697;5229.241759944786;6003.489703375175;6017.518598512109;6065.727042283108;6137.294211165773;886.6940905387631;926.9560618835452;956.7990721948469;1069.79139067881;1158.988410115905;28806.85596572004;30259;30385.696143038727;30542.21514420077;30978.845105774326;1057.4818339013827;1061.851340812287;1063.1654151491043;1085.5983286184162;1142.457332766929;15814.367425302858;16297.755533666766;16361.363863613544;16402.589935251475;16427.753583696252;469094;473362;474014;474063;475987;47630;48068.75965620219;53154;54235.72882135564;54239.45760542423;1283.525095714573;1299.8469888705683;1316.1182008054627;1320.7886738122047;1325.370449036719;29861.272764193312;31805.840970794998;32114.839425802722;32240.19399515031;32622.673773261962;48996.265056023476;49416.25875611797;49505.25742113799;49508.50491495183;49510.50489495059;437829;438452;440150;440639;444377;25631;26323.868380657976;26424.471510569296;27842.0765819586;38561.80719096387;44504.77747611241;45241;45592.54407455883;45729.31406028846;46268;38126.618733812305;38428.930786282006;38845.80577097096;39468.60531394764;40182.39726404165;38185.618143819316;38506.229875401776;38872.805635971636;40217.1956560873;40249;38116.618833811306;39797;39912.20175596414;40060.399094014196;40100;31818.84090579532;33907.25298458168;33982.83008584941;34142.487862681584;34512.30975380528;26048.34879128037;26503.469930600895;26713.041055266378;26826;26965.595516066882 06:12:53 INFO - PROCESS | 28573 | |2;jquery.html;371.33345644568;380.950476438063;388.9961100388996;389.9356606159983;418.5835094081389;14045.578632641025;15445.6138596535;18071.81928180721;18749.812501874978;18772.249110035584;18455.90772046141;18472.261109555602;18519.629607407845;18754.531136721587;18756.71864922027;4107.691923105764;5439.156930675732;5646.350669672978;5673.886522269552;5689.687067211302;4226.260404429228;6015.608985415934;6251.531135164858;6307.337729538402;6419.967900160493;6228.719707613168;6229.719662615194;6289;6382.936170638304;6385.169927909388;6281.214848143982;6295.213098362705;6300.59046161998;6312.715927783261;6316.684165791692;5385.192221166817;5552.278203833475;5596.552275817966;5598.4961353477975;5598.496135347838;22021.779782202295;22605.77394226053;22668.433289167737;22699.205527806447;22790.974406151763;2269.5574362999223;2332.7433982261937;2334.2180369576213;2575.974240257592;2838.985805070982;13917.747402733803;14090.577282681536;14100.717985640333;14353.641158971004;14630.853691463055;1823.6626224148574;1938;1942.0678074524308;1942.2813558983266;1953.8436925045962;78198.6090069546;78500;78990.21009789943;79232.60383698044;79258;10051.246156538142;10247;10342.896571034344;10357.844632330522;10580.206484513692;14411.207383594003;14511.564653060213;14539.563813085624;14545.563633091024;14606.488772892897;7669.769906902802;7835.294823465915;7944.44388892772;7990.880136797953;8096.878546821685;7656.3874890008665;7727.188645192174;7892.26557973178;7927.682892684344;7977.441579089524;6112.358202388685;6327.620342779356;6349.301576826545;6375.489960803125;6400.967995159995;1841.250811728863;1855.3135339924045;1875.8708865437827;1908.765777702492;1921.2507122222344;460.3003434779117;467.2244074835824;911.9361644684808;928.9117533834275;932.3007744191856;10833.241673082966;11310.532339725927;11946.234469147672;11988.940055299841;11994.76010479803;471.0437811243182;477.59165913144454;478.4904077157816;482.2091769498026;485.5508654494649;6346.8413289667205;6378.394052564999;6502.7644747497825;6591.802245932629;6721.395074443226;400863;414279;414294;420949;421596;53335;76659;76742.84885726719;88001.55999219963;93040.53479732558;471.6227018385278;479.35526716566164;479.36005432747675;480.7884530806434;481.94457637372153;11037.448127593427;11169.497372618414;11274;11568.305901645592;11623.418829058683;39638;39950;40508.79745601253;41183.8211772242;41195.38206926839;54683.179752304546;55920;56838.7158064207;57209.42790572041;58992.41007589869;8285;8373.581320933807;8500.14998500145;8516.233538981522;8560.743177704679;11945.701357466132;11950.103742219195;12154.574589889311;12308.692282693004;12328.32194229326;10531;10862.619808306672;11034.282771619819;11114.944425277821;11410.315381077162;10675.946620266848;10725.30285531438;10780.407077610807;10840.728981775519;10903.236773425784;10857.457127143452;10957.452127393757;10976.573045504034;11000.504977275881;11340.149488788209;8267;8404.705835295736;8415.11641277657;8514.276286515715;8534.487930724177;9364.076898633544;10834.453903332867;10944.288621239593;10998.725031874266;11048.337099773718 06:12:53 INFO - PROCESS | 28573 | |3;mootools.html;1299.8830105290522;1439.9856001439982;1481.7555103407938;1546.6520032992578;1707.2488105233704;7740.148583655793;8444.113368096347;8797.120287971216;8839.779005524864;9036.367454278203;8698.347623928215;8799.91200087999;8803.95598022009;8808.515531645757;8809.339299552526;2272.7045683859255;2293.9655905161353;2299.678045073691;2305.7578954209816;2306.630939049752;2198.373463562885;2255.548890221954;2261.954760904781;2262.9773702262933;2273.193016479151;2292.90828366866;2316.420894776306;2324.895379707917;2325.7557956414585;2332.055517515409;2267;2304.089884495623;2309.8036666883336;2317.3974766560646;2323.105604342332;2251.268337790225;2263.2757517594378;2263.5133446309123;2263.954720905589;2266.705328307326;8586.957065214696;8609.827803443959;8647.264982476498;8684.60919258635;8696.347773916981;5195.558377537914;5259.815906443256;5313.681179129265;5323.494268044568;5323.733813309358;3437.5187473753695;3479.304139172176;3491.790492570454;3569.5716514018222;3594.5327107476123;1034.0693375961619;1059.3749687684226;2046.334941144134;2053.1582051358873;2053.2300387354744;12110.39448027595;12117.39413029345;12209;12211.145219834616;12216.816747748791;4377.649788016951;4448.977755111268;4631;4636.6058884995155;4637.582617564435;9494.430334179971;9505.144536991565;9506.619735210514;9512.621844538866;9516.524173791282;5252.868678282997;5262.578993680497;5263.499967503081;5266.447023062523;5268.1834315681135;4386.561343865652;4525.389072475239;4776.952230477651;4887.706737595756;4893.608511319086;3617.8835381302233;3673.981630091886;3744.7940363279736;3770.9245815083545;3786.734928554975;1132.3885102044803;1142.8514293141839;1147.500837135832;1154.1689983212075;1159.5072094359864;833;859.5831021954347;951.6193522591019;959.6689142245914;976.7497603068084;5921.6743079131065;5949.226600541989;5950.8809823803285;6072.136345620311;6113.358097399798;410.41310925376996;410.69813686940074;412.71316435077335;415.1385874310757;422.56686895931915;4097.13960068383;4164.12553363797;4187.45563076798;4206.221848957953;4213.199492096492;10591.205659575562;11079.612213572485;11096.833547496793;11183.944080279547;11194.160437967184;10924.453777311262;10934.4532773361;10951.671449856518;11011.119110471143;11011.779764404828;8136.918630813616;8184.6316915738935;8201.507909525448;8205.399947010275;8209.507429554127;5848.2689663792025;5885.882282354414;5918.704064796829;6032.517398608188;6045.637261764308;9775.120239178508;10169.9491502542;10194.796104077728;10230.437325947145;10235.232357573062;10268.845967310346;10292.536835842255;10401.219908507044;10432.217583681102;10438.843417348595;6663.866722665616;6839.93160068393;7119.2524784898915;7430.851382972419;7492.288232617892;8396.622152003296;8559.14408559164;8559.700410485602;8560.443571167854;8560.785980350542;7300.050993370828;7341.596212208166;7388.926110739038;7431.40548756109;7580.204078571671;7357.087157339023;7370.262973702801;7470.813229669302;7521.849563008818;7758.4181186410115;6606.537542371988;6720.596764194164;6721.428678562377;6730.226024007106;6730.93269067303;5110;5206.333374890912;5279.683219006872;5385.8114965976;5503.532199762904;5254.106801843772;5335.946640533545;5370;5379.112446446293;5461.1262198048125 06:12:53 INFO - PROCESS | 28573 | |4;prototype.html;326.58686761247026;329.4794225124304;335.79852088746753;336.08081896014414;339.53314192984647;5172.844814655562;5199.766010529525;5204.16733322668;5214.828137490012;5302.893942121155;5221.112410890149;5246.37043554773;5276;5301.151815709487;5305.495977882105;3941.329973904436;4043.9797801010955;4059.63463288304;4101.118259574191;4114.382842573608;4121.958780412202;4124.381342798574;4148.647364973981;4150.190712811003;4151.688623353246;4083.2650122977852;4084.284600467796;4097.180563887219;4105.815238314283;4114.691398145136;3733.850645974158;3893.8831835044994;3964.6630036446936;4109.8972525686795;4128.62842344189;3675.1807855111892;3686.8156592170285;3687.3547129252543;3691.1141326081815;3693.5752388475403;5148.433672296044;5152.252923326097;5162.767675454614;5168.948310516922;5181.766820493087;4422.977885110554;4609.746463944482;4656.883577910546;4741.549552792514;4770.308305295713;5454.809081682122;5458.536024437927;5470.480304371078;5475.835724928259;5478.863028424282;3963.207358528277;3982.4026396040535;3983.40248962655;3987.202559488114;4005.7396269242404;5446.1558458439;5665.886682266373;5697.572682048863;5763.971180144114;5801.680907550083;4002.799860006988;4005.819738111734;4009.8195581198916;4016.5983401660183;4032.8991775205855;4083.4079058536345;4087.4481944937647;4089.5092588889524;4091.5499295077516;4097.160082183145;4587.614440490926;4591.563801438858;4606.8157273708675;4655.4878963314;4707.835225767081;5432.103702888979;5464.316960379952;5475.780968761284;5479.780808767605;5488.38092762636;1393.5888912770756;1402.9337703345532;1412.3220853990142;1412.9505467308595;1413.1097408632495;906.2523418180028;912.4662072687552;920.6685593186447;921.5530467723283;936.0779632062413;5228.137357336073;5308.0009794466005;5335.866603334947;5339.199120131933;5354.678719276856;5639.548836093103;5661.207430959669;5670.121131224667;5676.517496012802;5697.6296540724725;5185.585153187736;5331.733413329318;5347.946520534822;5371.355437347544;5383.623146379794;2984.9552256716165;3006.1582756827684;3018.6679465258803;3019.124453908386;3032.5754394384803;5772.6536407815665;5773.162891380726;5785.247917770663;5795.928158076226;5843.3864444233595;5472.554807966099;5760.452756988079;5764.5676574257095;5779.7110144493445;5804.158397032491;5836.124581312837;5843.451485356384;5845.9999999999145;5846.842704939285;5851.590388672752;5476.945230547643;5558.972205138948;5611.579131565068;5659.943400566106;5718.656880587178;5558.44415558441;5560.1103823389685;5619.466150715675;5626.746796394254;5637.040553709336;5835.8832823342445;5853.151293062397;5869.383714709894;5896.587238893237;5901.7639294427745;3919.353306704362;4025.4766880305374;4057.837686492507;4066.5563724878425;4076.5311989120446;5659.179418984142;5661.773529058792;5693.4021927696995;5695.117256825199;5696.515796157208;5350.6254562180275;5554.555815487922;5567.359753628384;5589.630540517436;5598.496135347838;5504.91742623869;5508.779648814003;5541.972290138524;5562.527185189142;5577.776888924398;5287.920681189862;5537.674176845815;5539.612227144223;5562.831805320928;5564.527015203591;5384.623076384615;5476.780928762805;5552.611317207757;5580.414056524007;5592.916106258328;5464.26232458613;5465.672059676433;5467.387120799453;5479.178123281539;5490.396056433709 06:12:53 INFO - PROCESS | 28573 | |5;yui.html;649.366867304378;707.1337611426001;719.2914978745938;732.8277854704145;828.2876726015623;15073.472428464993;16024.83975160248;16034.198290085507;16041.278142483587;16120.838791612081;14187.43250269988;14224.359903804328;14239.572812815632;14258.144511329327;14261.286935653228;662.3376623376623;679.7043286170507;775.662586774752;782.2803021220491;806.1213277527494;791.6595863778573;801.390942883407;803.1406395157184;803.6664784114614;803.8633432316491;838.8364268967554;839.3243439031608;839.7144970709958;839.8446287436843;839.86562150056;685.8456847209338;704.4610872682402;806.9394795390369;824.2458150792019;826.3224156191895;609.3084349263573;616.6978180691474;617.0158597037718;617.7158507086746;617.9443850053472;14645.707085858223;14678.412863485448;14683.92658036703;14688.118712877154;14695.412183512646;14150.504732334422;14331.570052898429;14566.781498277534;14654.267286635626;14698.706025879423;12699.746005079847;12915.289659068747;12935.159214651112;13232.139910905857;13716.451341946311;4278.743275403485;4421.143821600875;4422.402975598286;4441.666874984389;4504.729716217037;76675.23324766736;76876.61561692212;76918;77357.84916564141;77815.6109219456;10977.3962432067;10979.451027448597;11055.668329950115;11219.66341009771;11462.885371146182;21652.783472165393;21817.454563636034;21848.672269915965;21906.561868762536;21983.34049978503;8068.9596552016865;8284.627191776264;8301.584920753938;8307.08622051574;8308.418410711192;4720.386349774507;4747.83382581608;4763.190257656207;4764.141984625999;4783.736894470768;3452.085197422685;3562.8931132066077;3565.0196196045777;3566.0728210665416;3567.1795487038125;583.3670467542679;619.6777675608658;620.1968450856152;622.2222222222222;624.1293395713045;651.9152510173742;692.536000879412;699.6641612026256;721.4452854099424;751.5152726491383;8785.472871627722;8887.511186884783;8919.197272245528;9250.491222982666;9376.296777741696;596.5704692621306;621.3724138620026;633.398271641942;680.3332733920786;683.8871586188322;4294.742315461082;4349.173657005159;4514.052049069666;4542.909141817211;4769.73766442842;108913.47495038013;114642;117133.41433292779;120202.3989880045;120895.39552302183;100691.49654251829;101817.49091254645;102693;103320;105443;61780;89035;90035;91317.99999999868;95060.52469737883;8447.281981031681;8479.321654267767;8571.314294856522;8650.394472386872;8767.363707980596;51400.74299628478;52067;53600.463995361104;53720.731396342766;54179.187312191134;77512.61243693746;78141;79208.60395697984;80737.19262807297;82851.5857420709;10837.403942782907;10940.234183607072;11103.888961110608;11166.330020198815;11697.590584329508;12536.247825130156;12721.872781272068;12844;13067.738645226853;13227.140235884637;11136.053435458076;11162.38606876597;11649.359285239394;11771.823422648838;11865.644030679094;10696.839547406951;11077.169212308949;11084.833727494255;11428.25716328436;11453.828192576952;11123.053192018968;11570.247933884271;12067.336296503776;12316.507339706312;12335.136540442083;9451.858222126812;9528.380655257386;9563.139317461462;10038.49807509607;10225.590976360862;8950.23922966555;9057.77355566116;9965.537047673475;10518.378699583904;10647.414392208502 06:12:53 INFO - PROCESS | 28573 | __end_tp_report 06:12:53 INFO - PROCESS | 28573 | __start_cc_report 06:12:53 INFO - PROCESS | 28573 | _x_x_mozilla_cycle_collect,1088 06:12:53 INFO - PROCESS | 28573 | __end_cc_report 06:12:53 INFO - PROCESS | 28573 | __startTimestamp1477314773451__endTimestamp 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | ------- Summary: start ------- 06:12:53 INFO - PROCESS | 28573 | Number of tests: 6 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | [#0] dojo.html Cycles:165 Average:5347.08 Median:5580.97 stddev:595.58 (10.7%) stddev-sans-first:570.66 06:12:53 INFO - PROCESS | 28573 | Values: 3097.2 3117.3 3149.3 3159.7 3163.2 5176.5 5246.5 5396.6 5483.7 5486.9 5255.8 5272.9 5273.5 5283.2 5288.0 4760.7 4771.8 4788.6 4819.2 4827.6 4993.6 4995.8 5032.7 5033.3 5033.7 4865.5 4880.2 4905.7 4962.0 5023.9 4997.0 5023.7 5030.4 5031.5 5089.6 4811.4 4851.3 4882.7 4926.7 4940.4 5298.9 5306.0 5318.0 5340.1 5397.4 5639.2 5694.0 5694.1 5695.9 5698.7 5727.5 5754.5 5792.0 5831.2 5892.0 5481.5 5482.3 5483.0 5490.1 5491.3 5810.2 5836.2 5889.1 5972.2 5979.0 5594.1 5598.4 5599.4 5657.3 5665.1 5641.2 5684.5 5690.9 5698.1 5704.6 5581.0 5599.0 5628.8 5671.4 5675.7 5707.7 5717.3 5723.7 5723.7 5724.8 4341.9 4369.3 4371.2 4375.7 4377.0 3961.6 3968.4 3969.3 3971.0 3972.1 5395.8 5403.3 5407.2 5407.4 5407.7 5772.2 5792.4 5799.0 5822.5 5824.8 5474.9 5475.5 5476.4 5478.5 5535.1 4960.4 4974.8 4983.4 5000.8 5032.4 5720.8 5771.9 5781.6 5876.4 5983.4 5768.8 5807.6 5855.0 5865.1 5876.6 5956.2 5957.3 5958.0 5964.9 5966.0 5563.6 5597.5 5660.0 5677.1 5679.7 5718.9 5723.9 5728.3 5760.4 5824.4 5630.8 5634.0 5639.3 5641.2 5642.1 5542.8 5550.5 5573.7 5576.8 5586.7 5389.1 5490.8 5631.7 5690.7 5695.8 5703.1 5733.3 5738.8 5738.9 5785.3 5606.8 5619.1 5621.0 5622.0 5628.4 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | [#1] ext.html Cycles:180 Average:56649.47 Median:38467.58 stddev:109875.69 (285.6%) stddev-sans-first:110103.20 06:12:53 INFO - PROCESS | 28573 | Values: 553.6 603.8 614.3 638.5 644.0 30650.5 31529.5 41805.6 42963.4 43022.1 39973.2 43353.8 43429.3 43437.8 43456.8 8664.8 8803.3 8807.6 8822.7 8824.6 8008.6 8199.8 8665.2 10289.8 10538.9 10699.2 10726.5 10750.5 10763.7 10769.6 10608.9 10664.3 10693.0 10694.4 10700.9 10400.7 10466.6 10475.1 10482.1 10488.7 41412.8 41816.2 41821.6 41907.4 41919.2 3369.2 3471.0 3873.0 3995.4 4055.5 29731.7 30618.4 30745.7 30873.7 32548.8 4014.4 4115.5 4172.7 4267.6 4312.6 314002.0 314678.0 314742.0 315453.0 317889.0 55506.2 55679.7 55917.4 55919.7 56079.2 57757.0 57764.0 58150.7 58235.7 58322.0 16060.1 16299.3 16307.8 16314.3 16314.9 11192.7 12154.3 12166.1 12168.2 12188.3 14254.6 15662.7 16079.0 16117.1 16630.9 5229.2 6003.5 6017.5 6065.7 6137.3 886.7 927.0 956.8 1069.8 1159.0 28806.9 30259.0 30385.7 30542.2 30978.8 1057.5 1061.9 1063.2 1085.6 1142.5 15814.4 16297.8 16361.4 16402.6 16427.8 469094.0 473362.0 474014.0 474063.0 475987.0 47630.0 48068.8 53154.0 54235.7 54239.5 1283.5 1299.8 1316.1 1320.8 1325.4 29861.3 31805.8 32114.8 32240.2 32622.7 48996.3 49416.3 49505.3 49508.5 49510.5 437829.0 438452.0 440150.0 440639.0 444377.0 25631.0 26323.9 26424.5 27842.1 38561.8 44504.8 45241.0 45592.5 45729.3 46268.0 38126.6 38428.9 38845.8 39468.6 40182.4 38185.6 38506.2 38872.8 40217.2 40249.0 38116.6 39797.0 39912.2 40060.4 40100.0 31818.8 33907.3 33982.8 34142.5 34512.3 26048.3 26503.5 26713.0 26826.0 26965.6 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | [#2] jquery.html Cycles:180 Average:25746.28 Median:414286.50 stddev:68561.05 (16.5%) stddev-sans-first:68726.91 06:12:53 INFO - PROCESS | 28573 | Values: 371.3 381.0 389.0 389.9 418.6 14045.6 15445.6 18071.8 18749.8 18772.2 18455.9 18472.3 18519.6 18754.5 18756.7 4107.7 5439.2 5646.4 5673.9 5689.7 4226.3 6015.6 6251.5 6307.3 6420.0 6228.7 6229.7 6289.0 6382.9 6385.2 6281.2 6295.2 6300.6 6312.7 6316.7 5385.2 5552.3 5596.6 5598.5 5598.5 22021.8 22605.8 22668.4 22699.2 22791.0 2269.6 2332.7 2334.2 2576.0 2839.0 13917.7 14090.6 14100.7 14353.6 14630.9 1823.7 1938.0 1942.1 1942.3 1953.8 78198.6 78500.0 78990.2 79232.6 79258.0 10051.2 10247.0 10342.9 10357.8 10580.2 14411.2 14511.6 14539.6 14545.6 14606.5 7669.8 7835.3 7944.4 7990.9 8096.9 7656.4 7727.2 7892.3 7927.7 7977.4 6112.4 6327.6 6349.3 6375.5 6401.0 1841.3 1855.3 1875.9 1908.8 1921.3 460.3 467.2 911.9 928.9 932.3 10833.2 11310.5 11946.2 11988.9 11994.8 471.0 477.6 478.5 482.2 485.6 6346.8 6378.4 6502.8 6591.8 6721.4 400863.0 414279.0 414294.0 420949.0 421596.0 53335.0 76659.0 76742.8 88001.6 93040.5 471.6 479.4 479.4 480.8 481.9 11037.4 11169.5 11274.0 11568.3 11623.4 39638.0 39950.0 40508.8 41183.8 41195.4 54683.2 55920.0 56838.7 57209.4 58992.4 8285.0 8373.6 8500.1 8516.2 8560.7 11945.7 11950.1 12154.6 12308.7 12328.3 10531.0 10862.6 11034.3 11114.9 11410.3 10675.9 10725.3 10780.4 10840.7 10903.2 10857.5 10957.5 10976.6 11000.5 11340.1 8267.0 8404.7 8415.1 8514.3 8534.5 9364.1 10834.5 10944.3 10998.7 11048.3 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | [#3] mootools.html Cycles:180 Average:5734.59 Median:4707.27 stddev:3268.49 (69.4%) stddev-sans-first:3260.67 06:12:53 INFO - PROCESS | 28573 | Values: 1299.9 1440.0 1481.8 1546.7 1707.2 7740.1 8444.1 8797.1 8839.8 9036.4 8698.3 8799.9 8804.0 8808.5 8809.3 2272.7 2294.0 2299.7 2305.8 2306.6 2198.4 2255.5 2262.0 2263.0 2273.2 2292.9 2316.4 2324.9 2325.8 2332.1 2267.0 2304.1 2309.8 2317.4 2323.1 2251.3 2263.3 2263.5 2264.0 2266.7 8587.0 8609.8 8647.3 8684.6 8696.3 5195.6 5259.8 5313.7 5323.5 5323.7 3437.5 3479.3 3491.8 3569.6 3594.5 1034.1 1059.4 2046.3 2053.2 2053.2 12110.4 12117.4 12209.0 12211.1 12216.8 4377.6 4449.0 4631.0 4636.6 4637.6 9494.4 9505.1 9506.6 9512.6 9516.5 5252.9 5262.6 5263.5 5266.4 5268.2 4386.6 4525.4 4777.0 4887.7 4893.6 3617.9 3674.0 3744.8 3770.9 3786.7 1132.4 1142.9 1147.5 1154.2 1159.5 833.0 859.6 951.6 959.7 976.7 5921.7 5949.2 5950.9 6072.1 6113.4 410.4 410.7 412.7 415.1 422.6 4097.1 4164.1 4187.5 4206.2 4213.2 10591.2 11079.6 11096.8 11183.9 11194.2 10924.5 10934.5 10951.7 11011.1 11011.8 8136.9 8184.6 8201.5 8205.4 8209.5 5848.3 5885.9 5918.7 6032.5 6045.6 9775.1 10169.9 10194.8 10230.4 10235.2 10268.8 10292.5 10401.2 10432.2 10438.8 6663.9 6839.9 7119.3 7430.9 7492.3 8396.6 8559.1 8559.7 8560.4 8560.8 7300.1 7341.6 7388.9 7431.4 7580.2 7357.1 7370.3 7470.8 7521.8 7758.4 6606.5 6720.6 6721.4 6730.2 6730.9 5110.0 5206.3 5279.7 5385.8 5503.5 5254.1 5335.9 5370.0 5379.1 5461.1 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | [#4] prototype.html Cycles:180 Average:4645.66 Median:5337.53 stddev:1367.98 (25.6%) stddev-sans-first:1332.86 06:12:53 INFO - PROCESS | 28573 | Values: 326.6 329.5 335.8 336.1 339.5 5172.8 5199.8 5204.2 5214.8 5302.9 5221.1 5246.4 5276.0 5301.2 5305.5 3941.3 4044.0 4059.6 4101.1 4114.4 4122.0 4124.4 4148.6 4150.2 4151.7 4083.3 4084.3 4097.2 4105.8 4114.7 3733.9 3893.9 3964.7 4109.9 4128.6 3675.2 3686.8 3687.4 3691.1 3693.6 5148.4 5152.3 5162.8 5168.9 5181.8 4423.0 4609.7 4656.9 4741.5 4770.3 5454.8 5458.5 5470.5 5475.8 5478.9 3963.2 3982.4 3983.4 3987.2 4005.7 5446.2 5665.9 5697.6 5764.0 5801.7 4002.8 4005.8 4009.8 4016.6 4032.9 4083.4 4087.4 4089.5 4091.5 4097.2 4587.6 4591.6 4606.8 4655.5 4707.8 5432.1 5464.3 5475.8 5479.8 5488.4 1393.6 1402.9 1412.3 1413.0 1413.1 906.3 912.5 920.7 921.6 936.1 5228.1 5308.0 5335.9 5339.2 5354.7 5639.5 5661.2 5670.1 5676.5 5697.6 5185.6 5331.7 5347.9 5371.4 5383.6 2985.0 3006.2 3018.7 3019.1 3032.6 5772.7 5773.2 5785.2 5795.9 5843.4 5472.6 5760.5 5764.6 5779.7 5804.2 5836.1 5843.5 5846.0 5846.8 5851.6 5476.9 5559.0 5611.6 5659.9 5718.7 5558.4 5560.1 5619.5 5626.7 5637.0 5835.9 5853.2 5869.4 5896.6 5901.8 3919.4 4025.5 4057.8 4066.6 4076.5 5659.2 5661.8 5693.4 5695.1 5696.5 5350.6 5554.6 5567.4 5589.6 5598.5 5504.9 5508.8 5542.0 5562.5 5577.8 5287.9 5537.7 5539.6 5562.8 5564.5 5384.6 5476.8 5552.6 5580.4 5592.9 5464.3 5465.7 5467.4 5479.2 5490.4 06:12:53 INFO - PROCESS | 28573 | 06:12:53 INFO - PROCESS | 28573 | [#5] yui.html Cycles:180 Average:20762.46 Median:4763.67 stddev:30818.78 (647.0%) stddev-sans-first:30868.23 06:12:53 INFO - PROCESS | 28573 | Values: 649.4 707.1 719.3 732.8 828.3 15073.5 16024.8 16034.2 16041.3 16120.8 14187.4 14224.4 14239.6 14258.1 14261.3 662.3 679.7 775.7 782.3 806.1 791.7 801.4 803.1 803.7 803.9 838.8 839.3 839.7 839.8 839.9 685.8 704.5 806.9 824.2 826.3 609.3 616.7 617.0 617.7 617.9 14645.7 14678.4 14683.9 14688.1 14695.4 14150.5 14331.6 14566.8 14654.3 14698.7 12699.7 12915.3 12935.2 13232.1 13716.5 4278.7 4421.1 4422.4 4441.7 4504.7 76675.2 76876.6 76918.0 77357.8 77815.6 10977.4 10979.5 11055.7 11219.7 11462.9 21652.8 21817.5 21848.7 21906.6 21983.3 8069.0 8284.6 8301.6 8307.1 8308.4 4720.4 4747.8 4763.2 4764.1 4783.7 3452.1 3562.9 3565.0 3566.1 3567.2 583.4 619.7 620.2 622.2 624.1 651.9 692.5 699.7 721.4 751.5 8785.5 8887.5 8919.2 9250.5 9376.3 596.6 621.4 633.4 680.3 683.9 4294.7 4349.2 4514.1 4542.9 4769.7 108913.5 114642.0 117133.4 120202.4 120895.4 100691.5 101817.5 102693.0 103320.0 105443.0 61780.0 89035.0 90035.0 91318.0 95060.5 8447.3 8479.3 8571.3 8650.4 8767.4 51400.7 52067.0 53600.5 53720.7 54179.2 77512.6 78141.0 79208.6 80737.2 82851.6 10837.4 10940.2 11103.9 11166.3 11697.6 12536.2 12721.9 12844.0 13067.7 13227.1 11136.1 11162.4 11649.4 11771.8 11865.6 10696.8 11077.2 11084.8 11428.3 11453.8 11123.1 11570.2 12067.3 12316.5 12335.1 9451.9 9528.4 9563.1 10038.5 10225.6 8950.2 9057.8 9965.5 10518.4 10647.4 06:12:53 INFO - PROCESS | 28573 | -------- Summary: end -------- 06:12:53 INFO - PROCESS | 28573 | 06:12:54 INFO - TEST-INFO | 28573: exit 0 06:12:54 INFO - TEST-OK | dromaeo_css | took 1118579ms 06:12:54 INFO - TEST-START | kraken 06:12:54 INFO - operating with platform_type : linux_ 06:12:54 INFO - Initialising browser for kraken test... 06:12:54 INFO - TEST-INFO | started process 28880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWIDPXZ/profile http://localhost:59714/getInfo.html) 06:12:58 INFO - PROCESS | 28880 | __metrics Screen width/height:1600/1200 06:12:58 INFO - PROCESS | 28880 | colorDepth:24 06:12:58 INFO - PROCESS | 28880 | Browser inner width/height: 1024/697 06:12:58 INFO - PROCESS | 28880 | __metrics 06:12:58 INFO - PROCESS | 28880 | 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" 06:12:58 INFO - PROCESS | 28880 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:59 INFO - PROCESS | 28880 | console.error: PushService: 06:12:59 INFO - PROCESS | 28880 | stateChangeProcessEnqueue: Error transitioning state 06:12:59 INFO - PROCESS | 28880 | UnknownError 06:12:59 INFO - TEST-INFO | 28880: exit 0 06:12:59 INFO - Browser initialized. 06:12:59 INFO - Running cycle 1/1 for kraken test... 06:12:59 INFO - TEST-INFO | started process 28960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWIDPXZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:13:12 INFO - PROCESS | 28960 | RSS: Main: 172351488 06:13:12 INFO - PROCESS | 28960 | 06:13:14 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59714/tests/kraken/driver.html?testName=audio-beat-detection) 06:13:15 INFO - PROCESS | 28960 | RSS: Main: 237920256 06:13:15 INFO - PROCESS | 28960 | 06:13:18 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59714/tests/kraken/driver.html?testName=audio-dft) 06:13:18 INFO - PROCESS | 28960 | RSS: Main: 215494656 06:13:18 INFO - PROCESS | 28960 | 06:13:21 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59714/tests/kraken/driver.html?testName=audio-fft) 06:13:22 INFO - PROCESS | 28960 | RSS: Main: 297062400 06:13:22 INFO - PROCESS | 28960 | 06:13:24 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59714/tests/kraken/driver.html?testName=audio-oscillator) 06:13:25 INFO - PROCESS | 28960 | RSS: Main: 206581760 06:13:25 INFO - PROCESS | 28960 | 06:13:27 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:27 INFO - PROCESS | 28960 | RSS: Main: 211259392 06:13:27 INFO - PROCESS | 28960 | 06:13:30 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59714/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:31 INFO - PROCESS | 28960 | RSS: Main: 247910400 06:13:31 INFO - PROCESS | 28960 | 06:13:34 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59714/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:35 INFO - PROCESS | 28960 | RSS: Main: 246726656 06:13:35 INFO - PROCESS | 28960 | 06:13:37 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59714/tests/kraken/driver.html?testName=json-parse-financial) 06:13:38 INFO - PROCESS | 28960 | RSS: Main: 246538240 06:13:38 INFO - PROCESS | 28960 | 06:13:39 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:40 INFO - PROCESS | 28960 | RSS: Main: 209248256 06:13:40 INFO - PROCESS | 28960 | 06:13:42 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:42 INFO - PROCESS | 28960 | RSS: Main: 215220224 06:13:42 INFO - PROCESS | 28960 | 06:13:44 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:45 INFO - PROCESS | 28960 | RSS: Main: 225902592 06:13:45 INFO - PROCESS | 28960 | 06:13:48 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:48 INFO - PROCESS | 28960 | RSS: Main: 229588992 06:13:48 INFO - PROCESS | 28960 | 06:13:51 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:52 INFO - PROCESS | 28960 | RSS: Main: 230526976 06:13:52 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | Cycle 1(1): loaded http://localhost:59714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59714/tests/kraken/driver.html?testName=ai-astar) 06:13:54 INFO - PROCESS | 28960 | RSS: Main: 281612288 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | __start_tp_report 06:13:54 INFO - PROCESS | 28960 | _x_x_mozilla_page_load 06:13:54 INFO - PROCESS | 28960 | _x_x_mozilla_page_load_details 06:13:54 INFO - PROCESS | 28960 | |i|pagename|runs| 06:13:54 INFO - PROCESS | 28960 | |0;ai-astar;103;110;110;110;112;110;110;110;110;110 06:13:54 INFO - PROCESS | 28960 | |1;audio-beat-detection;150;123;122;162;124;122;122;123;150;121 06:13:54 INFO - PROCESS | 28960 | |2;audio-dft;161;161;161;160;159;161;160;164;161;160 06:13:54 INFO - PROCESS | 28960 | |3;audio-fft;75;76;77;122;75;76;75;76;98;75 06:13:54 INFO - PROCESS | 28960 | |4;audio-oscillator;83;82;114;83;82;82;112;83;83;118 06:13:54 INFO - PROCESS | 28960 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 06:13:54 INFO - PROCESS | 28960 | |6;imaging-darkroom;146;146;147;146;145;146;145;145;146;145 06:13:54 INFO - PROCESS | 28960 | |7;imaging-desaturate;84;85;84;84;84;84;84;84;84;84 06:13:54 INFO - PROCESS | 28960 | |8;json-parse-financial;55;51;52;52;52;59;52;52;55;51 06:13:54 INFO - PROCESS | 28960 | |9;json-stringify-tinderbox;59;59;58;58;59;58;58;58;60;59 06:13:54 INFO - PROCESS | 28960 | |10;stanford-crypto-aes;89;81;80;80;84;89;81;79;80;79 06:13:54 INFO - PROCESS | 28960 | |11;stanford-crypto-ccm;143;141;139;133;140;128;133;130;187;135 06:13:54 INFO - PROCESS | 28960 | |12;stanford-crypto-pbkdf2;164;165;162;164;164;166;162;164;164;167 06:13:54 INFO - PROCESS | 28960 | |13;stanford-crypto-sha256-iterative;67;65;66;67;67;66;67;66;66;63 06:13:54 INFO - PROCESS | 28960 | __end_tp_report 06:13:54 INFO - PROCESS | 28960 | __start_cc_report 06:13:54 INFO - PROCESS | 28960 | _x_x_mozilla_cycle_collect,1698 06:13:54 INFO - PROCESS | 28960 | __end_cc_report 06:13:54 INFO - PROCESS | 28960 | __startTimestamp1477314834274__endTimestamp 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | ------- Summary: start ------- 06:13:54 INFO - PROCESS | 28960 | Number of tests: 14 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:2.37 (2.2%) stddev-sans-first:0.67 06:13:54 INFO - PROCESS | 28960 | Values: 103.0 110.0 110.0 110.0 112.0 110.0 110.0 110.0 110.0 110.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#1] audio-beat-detection Cycles:10 Average:131.90 Median:123.50 stddev:15.62 (12.6%) stddev-sans-first:15.13 06:13:54 INFO - PROCESS | 28960 | Values: 150.0 123.0 122.0 162.0 124.0 122.0 122.0 123.0 150.0 121.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.39 06:13:54 INFO - PROCESS | 28960 | Values: 161.0 161.0 161.0 160.0 159.0 161.0 160.0 164.0 161.0 160.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#3] audio-fft Cycles:10 Average:82.50 Median:76.00 stddev:15.57 (20.5%) stddev-sans-first:16.28 06:13:54 INFO - PROCESS | 28960 | Values: 75.0 76.0 77.0 122.0 75.0 76.0 75.0 76.0 98.0 75.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:82.50 stddev:15.58 (18.9%) stddev-sans-first:16.16 06:13:54 INFO - PROCESS | 28960 | Values: 83.0 82.0 114.0 83.0 82.0 82.0 112.0 83.0 83.0 118.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:13:54 INFO - PROCESS | 28960 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 06:13:54 INFO - PROCESS | 28960 | Values: 146.0 146.0 147.0 146.0 145.0 146.0 145.0 145.0 146.0 145.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 06:13:54 INFO - PROCESS | 28960 | Values: 84.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 84.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#8] json-parse-financial Cycles:10 Average:53.10 Median:52.00 stddev:2.51 (4.8%) stddev-sans-first:2.57 06:13:54 INFO - PROCESS | 28960 | Values: 55.0 51.0 52.0 52.0 52.0 59.0 52.0 52.0 55.0 51.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 06:13:54 INFO - PROCESS | 28960 | Values: 59.0 59.0 58.0 58.0 59.0 58.0 58.0 58.0 60.0 59.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:81.00 stddev:3.85 (4.8%) stddev-sans-first:3.21 06:13:54 INFO - PROCESS | 28960 | Values: 89.0 81.0 80.0 80.0 84.0 89.0 81.0 79.0 80.0 79.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:139.50 stddev:16.93 (12.1%) stddev-sans-first:17.94 06:13:54 INFO - PROCESS | 28960 | Values: 143.0 141.0 139.0 133.0 140.0 128.0 133.0 130.0 187.0 135.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.20 Median:164.00 stddev:1.55 (0.9%) stddev-sans-first:1.64 06:13:54 INFO - PROCESS | 28960 | Values: 164.0 165.0 162.0 164.0 164.0 166.0 162.0 164.0 164.0 167.0 06:13:54 INFO - PROCESS | 28960 | 06:13:54 INFO - PROCESS | 28960 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.50 stddev:1.25 (1.9%) stddev-sans-first:1.27 06:13:54 INFO - PROCESS | 28960 | Values: 67.0 65.0 66.0 67.0 67.0 66.0 67.0 66.0 66.0 63.0 06:13:54 INFO - PROCESS | 28960 | -------- Summary: end -------- 06:13:54 INFO - PROCESS | 28960 | 06:13:55 INFO - TEST-INFO | 28960: exit 0 06:13:55 INFO - TEST-OK | kraken | took 61127ms 06:13:55 INFO - SUITE-END | took 1179s 06:13:55 INFO - Completed test suite (00:19:40) 06:13:55 INFO - javascript benchmark 06:13:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.179247499413, 3117.3297740985686, 3149.259923917879, 3159.6682348353424, 3163.240822202672, 5176.482351764822, 5246.5278124968745, 5396.595255355849, 5483.670979741219, 5486.945130548694, 5255.816046438375, 5272.894542109156, 5273.499017593323, 5283.181106928422, 5287.973560132204, 4760.690555113923, 4771.832985845496, 4788.569028787409, 4819.204831202865, 4827.56551910328, 4993.6005119590345, 4995.750212489379, 5032.748362581856, 5033.320501732256, 5033.748312584375, 4865.5134486551415, 4880.194767863316, 4905.656604037718, 4961.975190124044, 5023.899522009558, 4996.975015124937, 5023.673461225008, 5030.37120359955, 5031.47169547196, 5089.567386772129, 4811.374521312207, 4851.272309153655, 4882.6826256293225, 4926.729029903354, 4940.357753492023, 5298.947010529922, 5305.973470132663, 5318.042752304584, 5340.06548853949, 5397.352317721859, 5639.15412688096, 5694.032014557493, 5694.088945768699, 5695.914561281584, 5698.6865722385255, 5727.455891690282, 5754.510866576346, 5791.971040144815, 5831.212786273841, 5892.027815410452, 5481.451854814566, 5482.314710661168, 5483.040467918098, 5490.149026900797, 5491.341039075336, 5810.244668193192, 5836.241288632451, 5889.087191485327, 5972.223610930638, 5979.043353063489, 5594.13290939905, 5598.440155984369, 5599.356074051455, 5657.32112146545, 5665.12190610456, 5641.182028605911, 5684.488396044293, 5690.857728556819, 5698.088305871041, 5704.629199102045, 5580.972095139579, 5599.048161812501, 5628.831135065954, 5671.376148623648, 5675.687837168913, 5707.715763953161, 5717.256756621696, 5723.656580605177, 5723.742431590588, 5724.79963201286, 4341.934870976938, 4369.300911854151, 4371.19132960397, 4375.693701440932, 4377.015171586368, 3961.564227934925, 3968.3849003404516, 3969.3450580654444, 3971.0, 3972.1261322509004, 5395.78416863321, 5403.324584426947, 5407.161889906992, 5407.351117865803, 5407.729613519308, 5772.2207501986695, 5792.391798861143, 5798.985177593904, 5822.534197264209, 5824.825255242349, 5474.863128421821, 5475.534579560703, 5476.397596264408, 5478.506934375846, 5535.059039963216, 4960.429550601655, 4974.751262436864, 4983.377077865267, 5000.774965126578, 5032.370953630796, 5720.799772007959, 5771.942280577225, 5781.595288329777, 5876.382979787232, 5983.431574000463, 5768.769249229984, 5807.593468457168, 5854.970725146347, 5865.090910908816, 5876.588638795243, 5956.22569066036, 5957.255343082114, 5957.970210148921, 5964.9105263420215, 5966.0, 5563.638363506359, 5597.524210442158, 5660.0, 5677.063284558167, 5679.659220446786, 5718.8570285741525, 5723.885522289447, 5728.283964504437, 5760.395158508296, 5824.446677565625, 5630.831075067591, 5633.971830140823, 5639.295088113986, 5641.238432811518, 5642.097264437671, 5542.750576223999, 5550.473619754438, 5573.693446860461, 5576.832695019156, 5586.748596313095, 5389.137737961907, 5490.835274941758, 5631.6902570359025, 5690.743916523849, 5695.772169113355, 5703.144528320785, 5733.283339582552, 5738.770449182153, 5738.942610573841, 5785.27684039495, 5606.803761868315, 5619.072852979212, 5621.044422448112, 5622.01614717431, 5628.380878103487], "value": 5307.559022376654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.6346011632321, 603.7977277612, 614.2506142506144, 638.511538672915, 643.9921522816788, 30650.54024189636, 31529.527057094132, 41805.58194418055, 42963.35554966678, 43022.13955720884, 39973.200535989265, 43353.78323108388, 43429.34855977163, 43437.78281108598, 43456.782716086454, 8664.826703465927, 8803.33974951878, 8807.64769409223, 8822.73531794044, 8824.558772061404, 8008.599570021504, 8199.79500512486, 8665.220130188281, 10289.845652315222, 10538.947305263462, 10699.164721348849, 10726.517306721216, 10750.462476876164, 10763.677089687282, 10769.569217231341, 10608.946955265214, 10664.306820056672, 10693.037626613643, 10694.411807350592, 10700.892991070068, 10400.739981500446, 10466.581336746598, 10475.057244847923, 10482.109020733247, 10488.68533943983, 41412.79293603543, 41816.1636767266, 41821.581784182075, 41907.37138942918, 41919.161616767495, 3369.1913940654313, 3470.9652903471147, 3872.961270387288, 3995.360742281221, 4055.472788537501, 29731.70268297311, 30618.38763224723, 30745.692543074507, 30873.691263087305, 32548.83725581357, 4014.3777714454013, 4115.485564304462, 4172.687048471377, 4267.594578515036, 4312.5903039211225, 314002.0, 314678.0, 314742.0, 315453.0, 317889.0, 55506.16740748892, 55679.721601391735, 55917.36537125074, 55919.72040139855, 56079.15881261785, 57757.0, 57764.0, 58150.709246453494, 58235.70882145562, 58322.0, 16060.072791264889, 16299.266533006043, 16307.836921630631, 16314.347426102822, 16314.918425408034, 11192.664220073411, 12154.331511766937, 12166.148369614042, 12168.209066410654, 12188.268703877795, 14254.643633909236, 15662.650602409729, 16079.0, 16117.113558754381, 16630.916845415697, 5229.241759944786, 6003.489703375175, 6017.518598512109, 6065.727042283108, 6137.294211165773, 886.6940905387631, 926.9560618835452, 956.7990721948469, 1069.79139067881, 1158.988410115905, 28806.85596572004, 30259.0, 30385.696143038727, 30542.21514420077, 30978.845105774326, 1057.4818339013827, 1061.851340812287, 1063.1654151491043, 1085.5983286184162, 1142.457332766929, 15814.367425302858, 16297.755533666766, 16361.363863613544, 16402.589935251475, 16427.753583696252, 469094.0, 473362.0, 474014.0, 474063.0, 475987.0, 47630.0, 48068.75965620219, 53154.0, 54235.72882135564, 54239.45760542423, 1283.525095714573, 1299.8469888705683, 1316.1182008054627, 1320.7886738122047, 1325.370449036719, 29861.272764193312, 31805.840970794998, 32114.839425802722, 32240.19399515031, 32622.673773261962, 48996.265056023476, 49416.25875611797, 49505.25742113799, 49508.50491495183, 49510.50489495059, 437829.0, 438452.0, 440150.0, 440639.0, 444377.0, 25631.0, 26323.868380657976, 26424.471510569296, 27842.0765819586, 38561.80719096387, 44504.77747611241, 45241.0, 45592.54407455883, 45729.31406028846, 46268.0, 38126.618733812305, 38428.930786282006, 38845.80577097096, 39468.60531394764, 40182.39726404165, 38185.618143819316, 38506.229875401776, 38872.805635971636, 40217.1956560873, 40249.0, 38116.618833811306, 39797.0, 39912.20175596414, 40060.399094014196, 40100.0, 31818.84090579532, 33907.25298458168, 33982.83008584941, 34142.487862681584, 34512.30975380528, 26048.34879128037, 26503.469930600895, 26713.041055266378, 26826.0, 26965.595516066882], "value": 19543.249008650895, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.33345644568, 380.950476438063, 388.9961100388996, 389.9356606159983, 418.5835094081389, 14045.578632641025, 15445.6138596535, 18071.81928180721, 18749.812501874978, 18772.249110035584, 18455.90772046141, 18472.261109555602, 18519.629607407845, 18754.531136721587, 18756.71864922027, 4107.691923105764, 5439.156930675732, 5646.350669672978, 5673.886522269552, 5689.687067211302, 4226.260404429228, 6015.608985415934, 6251.531135164858, 6307.337729538402, 6419.967900160493, 6228.719707613168, 6229.719662615194, 6289.0, 6382.936170638304, 6385.169927909388, 6281.214848143982, 6295.213098362705, 6300.59046161998, 6312.715927783261, 6316.684165791692, 5385.192221166817, 5552.278203833475, 5596.552275817966, 5598.4961353477975, 5598.496135347838, 22021.779782202295, 22605.77394226053, 22668.433289167737, 22699.205527806447, 22790.974406151763, 2269.5574362999223, 2332.7433982261937, 2334.2180369576213, 2575.974240257592, 2838.985805070982, 13917.747402733803, 14090.577282681536, 14100.717985640333, 14353.641158971004, 14630.853691463055, 1823.6626224148574, 1938.0, 1942.0678074524308, 1942.2813558983266, 1953.8436925045962, 78198.6090069546, 78500.0, 78990.21009789943, 79232.60383698044, 79258.0, 10051.246156538142, 10247.0, 10342.896571034344, 10357.844632330522, 10580.206484513692, 14411.207383594003, 14511.564653060213, 14539.563813085624, 14545.563633091024, 14606.488772892897, 7669.769906902802, 7835.294823465915, 7944.44388892772, 7990.880136797953, 8096.878546821685, 7656.3874890008665, 7727.188645192174, 7892.26557973178, 7927.682892684344, 7977.441579089524, 6112.358202388685, 6327.620342779356, 6349.301576826545, 6375.489960803125, 6400.967995159995, 1841.250811728863, 1855.3135339924045, 1875.8708865437827, 1908.765777702492, 1921.2507122222344, 460.3003434779117, 467.2244074835824, 911.9361644684808, 928.9117533834275, 932.3007744191856, 10833.241673082966, 11310.532339725927, 11946.234469147672, 11988.940055299841, 11994.76010479803, 471.0437811243182, 477.59165913144454, 478.4904077157816, 482.2091769498026, 485.5508654494649, 6346.8413289667205, 6378.394052564999, 6502.7644747497825, 6591.802245932629, 6721.395074443226, 400863.0, 414279.0, 414294.0, 420949.0, 421596.0, 53335.0, 76659.0, 76742.84885726719, 88001.55999219963, 93040.53479732558, 471.6227018385278, 479.35526716566164, 479.36005432747675, 480.7884530806434, 481.94457637372153, 11037.448127593427, 11169.497372618414, 11274.0, 11568.305901645592, 11623.418829058683, 39638.0, 39950.0, 40508.79745601253, 41183.8211772242, 41195.38206926839, 54683.179752304546, 55920.0, 56838.7158064207, 57209.42790572041, 58992.41007589869, 8285.0, 8373.581320933807, 8500.14998500145, 8516.233538981522, 8560.743177704679, 11945.701357466132, 11950.103742219195, 12154.574589889311, 12308.692282693004, 12328.32194229326, 10531.0, 10862.619808306672, 11034.282771619819, 11114.944425277821, 11410.315381077162, 10675.946620266848, 10725.30285531438, 10780.407077610807, 10840.728981775519, 10903.236773425784, 10857.457127143452, 10957.452127393757, 10976.573045504034, 11000.504977275881, 11340.149488788209, 8267.0, 8404.705835295736, 8415.11641277657, 8514.276286515715, 8534.487930724177, 9364.076898633544, 10834.453903332867, 10944.288621239593, 10998.725031874266, 11048.337099773718], "value": 8339.535189907772, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.8830105290522, 1439.9856001439982, 1481.7555103407938, 1546.6520032992578, 1707.2488105233704, 7740.148583655793, 8444.113368096347, 8797.120287971216, 8839.779005524864, 9036.367454278203, 8698.347623928215, 8799.91200087999, 8803.95598022009, 8808.515531645757, 8809.339299552526, 2272.7045683859255, 2293.9655905161353, 2299.678045073691, 2305.7578954209816, 2306.630939049752, 2198.373463562885, 2255.548890221954, 2261.954760904781, 2262.9773702262933, 2273.193016479151, 2292.90828366866, 2316.420894776306, 2324.895379707917, 2325.7557956414585, 2332.055517515409, 2267.0, 2304.089884495623, 2309.8036666883336, 2317.3974766560646, 2323.105604342332, 2251.268337790225, 2263.2757517594378, 2263.5133446309123, 2263.954720905589, 2266.705328307326, 8586.957065214696, 8609.827803443959, 8647.264982476498, 8684.60919258635, 8696.347773916981, 5195.558377537914, 5259.815906443256, 5313.681179129265, 5323.494268044568, 5323.733813309358, 3437.5187473753695, 3479.304139172176, 3491.790492570454, 3569.5716514018222, 3594.5327107476123, 1034.0693375961619, 1059.3749687684226, 2046.334941144134, 2053.1582051358873, 2053.2300387354744, 12110.39448027595, 12117.39413029345, 12209.0, 12211.145219834616, 12216.816747748791, 4377.649788016951, 4448.977755111268, 4631.0, 4636.6058884995155, 4637.582617564435, 9494.430334179971, 9505.144536991565, 9506.619735210514, 9512.621844538866, 9516.524173791282, 5252.868678282997, 5262.578993680497, 5263.499967503081, 5266.447023062523, 5268.1834315681135, 4386.561343865652, 4525.389072475239, 4776.952230477651, 4887.706737595756, 4893.608511319086, 3617.8835381302233, 3673.981630091886, 3744.7940363279736, 3770.9245815083545, 3786.734928554975, 1132.3885102044803, 1142.8514293141839, 1147.500837135832, 1154.1689983212075, 1159.5072094359864, 833.0, 859.5831021954347, 951.6193522591019, 959.6689142245914, 976.7497603068084, 5921.6743079131065, 5949.226600541989, 5950.8809823803285, 6072.136345620311, 6113.358097399798, 410.41310925376996, 410.69813686940074, 412.71316435077335, 415.1385874310757, 422.56686895931915, 4097.13960068383, 4164.12553363797, 4187.45563076798, 4206.221848957953, 4213.199492096492, 10591.205659575562, 11079.612213572485, 11096.833547496793, 11183.944080279547, 11194.160437967184, 10924.453777311262, 10934.4532773361, 10951.671449856518, 11011.119110471143, 11011.779764404828, 8136.918630813616, 8184.6316915738935, 8201.507909525448, 8205.399947010275, 8209.507429554127, 5848.2689663792025, 5885.882282354414, 5918.704064796829, 6032.517398608188, 6045.637261764308, 9775.120239178508, 10169.9491502542, 10194.796104077728, 10230.437325947145, 10235.232357573062, 10268.845967310346, 10292.536835842255, 10401.219908507044, 10432.217583681102, 10438.843417348595, 6663.866722665616, 6839.93160068393, 7119.2524784898915, 7430.851382972419, 7492.288232617892, 8396.622152003296, 8559.14408559164, 8559.700410485602, 8560.443571167854, 8560.785980350542, 7300.050993370828, 7341.596212208166, 7388.926110739038, 7431.40548756109, 7580.204078571671, 7357.087157339023, 7370.262973702801, 7470.813229669302, 7521.849563008818, 7758.4181186410115, 6606.537542371988, 6720.596764194164, 6721.428678562377, 6730.226024007106, 6730.93269067303, 5110.0, 5206.333374890912, 5279.683219006872, 5385.8114965976, 5503.532199762904, 5254.106801843772, 5335.946640533545, 5370.0, 5379.112446446293, 5461.1262198048125], "value": 4521.664793979983, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.58686761247026, 329.4794225124304, 335.79852088746753, 336.08081896014414, 339.53314192984647, 5172.844814655562, 5199.766010529525, 5204.16733322668, 5214.828137490012, 5302.893942121155, 5221.112410890149, 5246.37043554773, 5276.0, 5301.151815709487, 5305.495977882105, 3941.329973904436, 4043.9797801010955, 4059.63463288304, 4101.118259574191, 4114.382842573608, 4121.958780412202, 4124.381342798574, 4148.647364973981, 4150.190712811003, 4151.688623353246, 4083.2650122977852, 4084.284600467796, 4097.180563887219, 4105.815238314283, 4114.691398145136, 3733.850645974158, 3893.8831835044994, 3964.6630036446936, 4109.8972525686795, 4128.62842344189, 3675.1807855111892, 3686.8156592170285, 3687.3547129252543, 3691.1141326081815, 3693.5752388475403, 5148.433672296044, 5152.252923326097, 5162.767675454614, 5168.948310516922, 5181.766820493087, 4422.977885110554, 4609.746463944482, 4656.883577910546, 4741.549552792514, 4770.308305295713, 5454.809081682122, 5458.536024437927, 5470.480304371078, 5475.835724928259, 5478.863028424282, 3963.207358528277, 3982.4026396040535, 3983.40248962655, 3987.202559488114, 4005.7396269242404, 5446.1558458439, 5665.886682266373, 5697.572682048863, 5763.971180144114, 5801.680907550083, 4002.799860006988, 4005.819738111734, 4009.8195581198916, 4016.5983401660183, 4032.8991775205855, 4083.4079058536345, 4087.4481944937647, 4089.5092588889524, 4091.5499295077516, 4097.160082183145, 4587.614440490926, 4591.563801438858, 4606.8157273708675, 4655.4878963314, 4707.835225767081, 5432.103702888979, 5464.316960379952, 5475.780968761284, 5479.780808767605, 5488.38092762636, 1393.5888912770756, 1402.9337703345532, 1412.3220853990142, 1412.9505467308595, 1413.1097408632495, 906.2523418180028, 912.4662072687552, 920.6685593186447, 921.5530467723283, 936.0779632062413, 5228.137357336073, 5308.0009794466005, 5335.866603334947, 5339.199120131933, 5354.678719276856, 5639.548836093103, 5661.207430959669, 5670.121131224667, 5676.517496012802, 5697.6296540724725, 5185.585153187736, 5331.733413329318, 5347.946520534822, 5371.355437347544, 5383.623146379794, 2984.9552256716165, 3006.1582756827684, 3018.6679465258803, 3019.124453908386, 3032.5754394384803, 5772.6536407815665, 5773.162891380726, 5785.247917770663, 5795.928158076226, 5843.3864444233595, 5472.554807966099, 5760.452756988079, 5764.5676574257095, 5779.7110144493445, 5804.158397032491, 5836.124581312837, 5843.451485356384, 5845.9999999999145, 5846.842704939285, 5851.590388672752, 5476.945230547643, 5558.972205138948, 5611.579131565068, 5659.943400566106, 5718.656880587178, 5558.44415558441, 5560.1103823389685, 5619.466150715675, 5626.746796394254, 5637.040553709336, 5835.8832823342445, 5853.151293062397, 5869.383714709894, 5896.587238893237, 5901.7639294427745, 3919.353306704362, 4025.4766880305374, 4057.837686492507, 4066.5563724878425, 4076.5311989120446, 5659.179418984142, 5661.773529058792, 5693.4021927696995, 5695.117256825199, 5696.515796157208, 5350.6254562180275, 5554.555815487922, 5567.359753628384, 5589.630540517436, 5598.496135347838, 5504.91742623869, 5508.779648814003, 5541.972290138524, 5562.527185189142, 5577.776888924398, 5287.920681189862, 5537.674176845815, 5539.612227144223, 5562.831805320928, 5564.527015203591, 5384.623076384615, 5476.780928762805, 5552.611317207757, 5580.414056524007, 5592.916106258328, 5464.26232458613, 5465.672059676433, 5467.387120799453, 5479.178123281539, 5490.396056433709], "value": 4209.033989947461, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.366867304378, 707.1337611426001, 719.2914978745938, 732.8277854704145, 828.2876726015623, 15073.472428464993, 16024.83975160248, 16034.198290085507, 16041.278142483587, 16120.838791612081, 14187.43250269988, 14224.359903804328, 14239.572812815632, 14258.144511329327, 14261.286935653228, 662.3376623376623, 679.7043286170507, 775.662586774752, 782.2803021220491, 806.1213277527494, 791.6595863778573, 801.390942883407, 803.1406395157184, 803.6664784114614, 803.8633432316491, 838.8364268967554, 839.3243439031608, 839.7144970709958, 839.8446287436843, 839.86562150056, 685.8456847209338, 704.4610872682402, 806.9394795390369, 824.2458150792019, 826.3224156191895, 609.3084349263573, 616.6978180691474, 617.0158597037718, 617.7158507086746, 617.9443850053472, 14645.707085858223, 14678.412863485448, 14683.92658036703, 14688.118712877154, 14695.412183512646, 14150.504732334422, 14331.570052898429, 14566.781498277534, 14654.267286635626, 14698.706025879423, 12699.746005079847, 12915.289659068747, 12935.159214651112, 13232.139910905857, 13716.451341946311, 4278.743275403485, 4421.143821600875, 4422.402975598286, 4441.666874984389, 4504.729716217037, 76675.23324766736, 76876.61561692212, 76918.0, 77357.84916564141, 77815.6109219456, 10977.3962432067, 10979.451027448597, 11055.668329950115, 11219.66341009771, 11462.885371146182, 21652.783472165393, 21817.454563636034, 21848.672269915965, 21906.561868762536, 21983.34049978503, 8068.9596552016865, 8284.627191776264, 8301.584920753938, 8307.08622051574, 8308.418410711192, 4720.386349774507, 4747.83382581608, 4763.190257656207, 4764.141984625999, 4783.736894470768, 3452.085197422685, 3562.8931132066077, 3565.0196196045777, 3566.0728210665416, 3567.1795487038125, 583.3670467542679, 619.6777675608658, 620.1968450856152, 622.2222222222222, 624.1293395713045, 651.9152510173742, 692.536000879412, 699.6641612026256, 721.4452854099424, 751.5152726491383, 8785.472871627722, 8887.511186884783, 8919.197272245528, 9250.491222982666, 9376.296777741696, 596.5704692621306, 621.3724138620026, 633.398271641942, 680.3332733920786, 683.8871586188322, 4294.742315461082, 4349.173657005159, 4514.052049069666, 4542.909141817211, 4769.73766442842, 108913.47495038013, 114642.0, 117133.41433292779, 120202.3989880045, 120895.39552302183, 100691.49654251829, 101817.49091254645, 102693.0, 103320.0, 105443.0, 61780.0, 89035.0, 90035.0, 91317.99999999868, 95060.52469737883, 8447.281981031681, 8479.321654267767, 8571.314294856522, 8650.394472386872, 8767.363707980596, 51400.74299628478, 52067.0, 53600.463995361104, 53720.731396342766, 54179.187312191134, 77512.61243693746, 78141.0, 79208.60395697984, 80737.19262807297, 82851.5857420709, 10837.403942782907, 10940.234183607072, 11103.888961110608, 11166.330020198815, 11697.590584329508, 12536.247825130156, 12721.872781272068, 12844.0, 13067.738645226853, 13227.140235884637, 11136.053435458076, 11162.38606876597, 11649.359285239394, 11771.823422648838, 11865.644030679094, 10696.839547406951, 11077.169212308949, 11084.833727494255, 11428.25716328436, 11453.828192576952, 11123.053192018968, 11570.247933884271, 12067.336296503776, 12316.507339706312, 12335.136540442083, 9451.858222126812, 9528.380655257386, 9563.139317461462, 10038.49807509607, 10225.590976360862, 8950.23922966555, 9057.77355566116, 9965.537047673475, 10518.378699583904, 10647.414392208502], "value": 7282.878473805787, "unit": "score"}], "name": "dromaeo_css", "value": 7022.259388421455, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 122.0, 162.0, 124.0, 122.0, 122.0, 123.0, 150.0, 121.0], "value": 131.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 159.0, 161.0, 160.0, 164.0, 161.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 122.0, 75.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 82.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 83.0, 82.0, 82.0, 112.0, 83.0, 83.0, 118.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 52.0, 52.0, 52.0, 59.0, 52.0, 52.0, 55.0, 51.0], "value": 53.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 60.0, 59.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 80.0, 80.0, 84.0, 89.0, 81.0, 79.0, 80.0, 79.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 141.0, 139.0, 133.0, 140.0, 128.0, 133.0, 130.0, 187.0, 135.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 164.0, 164.0, 166.0, 162.0, 164.0, 164.0, 167.0], "value": 164.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 67.0, 67.0, 66.0, 67.0, 66.0, 66.0, 63.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1488.5000000000002, "alertThreshold": 2.0}]} 06:13:55 INFO - Return code: 0 06:13:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:56 INFO - # TBPL SUCCESS # 06:13:56 INFO - Running post-action listener: _resource_record_post_action 06:13:56 INFO - [mozharness: 2016-10-24 13:13:56.069923Z] Finished run-tests step (success) 06:13:56 INFO - Running post-run listener: _resource_record_post_run 06:13:56 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 303595520; Read time: 16; Write time: 206268 06:13:56 INFO - TinderboxPrint: CPU usage
13.0% 06:13:56 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 06:13:56 INFO - TinderboxPrint: I/O write bytes / time
303,595,520 / 206,268 06:13:56 INFO - TinderboxPrint: CPU idle
8,306.4 (87.0%) 06:13:56 INFO - TinderboxPrint: CPU user
1,195.9 (12.5%) 06:13:56 INFO - TinderboxPrint: Swap in / out
0 / 0 06:13:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 13979648; Read time: 0; Write time: 3360 06:13:56 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 289128448; Read time: 16; Write time: 202844 06:13:56 INFO - Running post-run listener: _upload_blobber_files 06:13:56 INFO - Blob upload gear active. 06:13:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:56 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 06:13:56 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:13:56 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:13:57 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:14:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:00 INFO - (blobuploader) - INFO - Done attempting. 06:14:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:14:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:14:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:01 INFO - (blobuploader) - INFO - Done attempting. 06:14:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:14:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:14:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:14:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:14:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:14:02 INFO - (blobuploader) - INFO - Done attempting. 06:14:02 INFO - (blobuploader) - INFO - Iteration through files over. 06:14:02 INFO - Return code: 0 06:14:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:14:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:14:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdb9398da8e6521d5623ec397cd0cd3ae099bab31fa587f8c905d3e74dec96100b5c7c1956ecabc2341726e4b67cb160d93d400643fad933d5674f348aed03fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab51649e16bf75296d282d5be2a21768b3e77a55f9c4e497a23fbe6b7387cf252b84c11dcf4684b2e54d79962998500db2e508576aafabd26bdef82d3bcb163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83223b15acd87898130b30ffa9fb3a6eb1cccd19e9f66067bb3c444e1bd7a3311fcbb906d84beec6966a4dd98ed3537bc521a6916f56b5f8956cdb2add27166"} 06:14:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:14:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:14:02 INFO - Contents: 06:14:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdb9398da8e6521d5623ec397cd0cd3ae099bab31fa587f8c905d3e74dec96100b5c7c1956ecabc2341726e4b67cb160d93d400643fad933d5674f348aed03fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab51649e16bf75296d282d5be2a21768b3e77a55f9c4e497a23fbe6b7387cf252b84c11dcf4684b2e54d79962998500db2e508576aafabd26bdef82d3bcb163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83223b15acd87898130b30ffa9fb3a6eb1cccd19e9f66067bb3c444e1bd7a3311fcbb906d84beec6966a4dd98ed3537bc521a6916f56b5f8956cdb2add27166"} 06:14:02 INFO - Running post-run listener: copy_logs_to_upload_dir 06:14:02 INFO - Copying logs to upload dir... 06:14:02 INFO - mkdir: /builds/slave/test/build/upload/logs 06:14:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1334.733180 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2016-10-24 06:13:59.682565) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 06:13:59.686133) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bdb9398da8e6521d5623ec397cd0cd3ae099bab31fa587f8c905d3e74dec96100b5c7c1956ecabc2341726e4b67cb160d93d400643fad933d5674f348aed03fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab51649e16bf75296d282d5be2a21768b3e77a55f9c4e497a23fbe6b7387cf252b84c11dcf4684b2e54d79962998500db2e508576aafabd26bdef82d3bcb163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83223b15acd87898130b30ffa9fb3a6eb1cccd19e9f66067bb3c444e1bd7a3311fcbb906d84beec6966a4dd98ed3537bc521a6916f56b5f8956cdb2add27166"} build_url:https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011374 build_url: 'https://queue.taskcluster.net/v1/task/VGuwgi1kSg2fMxigzg5X1A/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/Firefox/sha512/bdb9398da8e6521d5623ec397cd0cd3ae099bab31fa587f8c905d3e74dec96100b5c7c1956ecabc2341726e4b67cb160d93d400643fad933d5674f348aed03fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eab51649e16bf75296d282d5be2a21768b3e77a55f9c4e497a23fbe6b7387cf252b84c11dcf4684b2e54d79962998500db2e508576aafabd26bdef82d3bcb163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83223b15acd87898130b30ffa9fb3a6eb1cccd19e9f66067bb3c444e1bd7a3311fcbb906d84beec6966a4dd98ed3537bc521a6916f56b5f8956cdb2add27166"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-24 06:13:59.716006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 06:13:59.716377) ========= 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=3a3620fb28aea1604ab609ef000001d2-1477312636.836687-784989034 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004380 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-24 06:13:59.800716) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 06:13:59.801073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-24 06:13:59.801654) ========= ========= Total master_lag: 0.15 =========