builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1476155159.56 results: success (0) buildid: 20161010191246 builduid: ffdc096a4f194bd0888813d0939f0826 revision: 723c2e894079d0c870a1b78679f971c7a1d3d31f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.560435) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.561009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.561387) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.603207) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.603989) ========= 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=af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 20:05:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-10-10 20:05:59 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.198373 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.847528) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.847907) ========= 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=af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016887 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.898314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:05:59.898737) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 723c2e894079d0c870a1b78679f971c7a1d3d31f --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 723c2e894079d0c870a1b78679f971c7a1d3d31f --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=af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 20:06:00,024 truncating revision to first 12 chars 2016-10-10 20:06:00,024 Setting DEBUG logging. 2016-10-10 20:06:00,024 attempt 1/10 2016-10-10 20:06:00,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/723c2e894079?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 20:06:00,441 unpacking tar archive at: mozilla-central-723c2e894079/testing/mozharness/ program finished with exit code 0 elapsedTime=0.755083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:00.668272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:00.668682) ========= script_repo_revision: 723c2e894079d0c870a1b78679f971c7a1d3d31f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:00.669225) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:00.669604) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 20:06:00.694051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-10-10 20:06:00.694374) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:01 INFO - MultiFileLogger online at 20161010 20:06:01 in /builds/slave/test 20:06:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 20:06:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:01 INFO - {'append_to_log': False, 20:06:01 INFO - 'base_work_dir': '/builds/slave/test', 20:06:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 20:06:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:01 INFO - 'branch': 'Firefox-Non-PGO', 20:06:01 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:01 INFO - 'config_files': ('talos/linux_config.py',), 20:06:01 INFO - 'default_actions': ('clobber', 20:06:01 INFO - 'read-buildbot-config', 20:06:01 INFO - 'download-and-extract', 20:06:01 INFO - 'populate-webroot', 20:06:01 INFO - 'create-virtualenv', 20:06:01 INFO - 'install', 20:06:01 INFO - 'run-tests'), 20:06:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:01 INFO - 'download_minidump_stackwalk': True, 20:06:01 INFO - 'download_symbols': 'ondemand', 20:06:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:01 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:01 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:01 INFO - 'installer_path': 'installer.exe', 20:06:01 INFO - 'log_level': 'info', 20:06:01 INFO - 'log_name': 'talos', 20:06:01 INFO - 'log_to_console': True, 20:06:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:01 INFO - 'opt_config_files': (), 20:06:01 INFO - 'pip_index': False, 20:06:01 INFO - 'sps_profile': False, 20:06:01 INFO - 'sps_profile_interval': 0, 20:06:01 INFO - 'suite': 'dromaeojs', 20:06:01 INFO - 'system_bits': '32', 20:06:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:01 INFO - 'title': 'talos-linux64-ix-020', 20:06:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:01 INFO - 'use_talos_json': True, 20:06:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:01 INFO - 'work_dir': 'build'} 20:06:01 INFO - [mozharness: 2016-10-11 03:06:01.023590Z] Running clobber step. 20:06:01 INFO - Running pre-action listener: _resource_record_pre_action 20:06:01 INFO - Running main action method: clobber 20:06:01 INFO - rmtree: /builds/slave/test/build 20:06:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:01 INFO - Running post-action listener: _resource_record_post_action 20:06:01 INFO - [mozharness: 2016-10-11 03:06:01.438275Z] Finished clobber step (success) 20:06:01 INFO - [mozharness: 2016-10-11 03:06:01.438375Z] Running read-buildbot-config step. 20:06:01 INFO - Running pre-action listener: _resource_record_pre_action 20:06:01 INFO - Running main action method: read_buildbot_config 20:06:01 INFO - Using buildbot properties: 20:06:01 INFO - { 20:06:01 INFO - "project": "", 20:06:01 INFO - "product": "firefox", 20:06:01 INFO - "script_repo_revision": "production", 20:06:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 20:06:01 INFO - "repository": "", 20:06:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 20:06:01 INFO - "buildid": "20161010191246", 20:06:01 INFO - "pgo_build": "False", 20:06:01 INFO - "basedir": "/builds/slave/test", 20:06:01 INFO - "buildnumber": 240, 20:06:01 INFO - "slavename": "talos-linux64-ix-020", 20:06:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:06:01 INFO - "platform": "ubuntu64_hw", 20:06:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 20:06:01 INFO - "branch": "mozilla-central", 20:06:01 INFO - "repo_path": "mozilla-central", 20:06:01 INFO - "revision": "723c2e894079d0c870a1b78679f971c7a1d3d31f", 20:06:01 INFO - "stage_platform": "linux64", 20:06:01 INFO - "builduid": "ffdc096a4f194bd0888813d0939f0826", 20:06:01 INFO - "slavebuilddir": "test" 20:06:01 INFO - } 20:06:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:06:01 INFO - Running post-action listener: _resource_record_post_action 20:06:01 INFO - [mozharness: 2016-10-11 03:06:01.440793Z] Finished read-buildbot-config step (success) 20:06:01 INFO - [mozharness: 2016-10-11 03:06:01.440880Z] Running download-and-extract step. 20:06:01 INFO - Running pre-action listener: _resource_record_pre_action 20:06:01 INFO - Running main action method: download_and_extract 20:06:01 INFO - mkdir: /builds/slave/test/build/tests 20:06: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')]} 20:06:01 INFO - trying https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/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 20:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/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 20:06:01 INFO - Downloaded 1361 bytes. 20:06:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:06:02 INFO - Using the following test package requirements: 20:06:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'jsshell-linux-x86_64.zip'], 20:06:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:06:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:06:02 INFO - Http code: 200 20:06:02 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 20:06:02 INFO - x-amz-cf-id: SbeN-OJ4q9CL9PjiLonNC631XaredsT2TijT63cGaOBh84-ZKhRdaw== 20:06:02 INFO - x-amz-version-id: .smVkdX2qoYgrn0UfCYTRTnUDZ9QPPjc 20:06:02 INFO - Expected file size: 20528211 20:06:02 INFO - Obtained file size: 20528211 20:06:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:06:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:06:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:06:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:06:07 INFO - Http code: 200 20:06:07 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 20:06:07 INFO - x-amz-cf-id: 93T_9THnTWEvpdc3az6nV-K6k49z_BPjMMVKH6aiDllxuQat25VjjQ== 20:06:07 INFO - x-amz-version-id: .smVkdX2qoYgrn0UfCYTRTnUDZ9QPPjc 20:06:07 INFO - Expected file size: 20528211 20:06:07 INFO - Obtained file size: 20528211 20:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:06:13 INFO - Http code: 200 20:06:13 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 20:06:13 INFO - x-amz-cf-id: Yc62m949_OSIntlimGd5-or3AMFUFE0ZOBVUOViu44N7p_iSQjN-5g== 20:06:13 INFO - x-amz-version-id: 6ZWKVMVVg9DCJsIqcGG3KBuwRa1jCrLl 20:06:13 INFO - Expected file size: 14409006 20:06:13 INFO - Obtained file size: 14409006 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:13 INFO - trying https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:06:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/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 20:06:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/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 20:06:14 INFO - Downloaded 55872249 bytes. 20:06:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:06:14 INFO - mkdir: /builds/slave/test/properties 20:06:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:14 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:14 INFO - Contents: 20:06:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:06:15 INFO - Running post-action listener: _resource_record_post_action 20:06:15 INFO - Running post-action listener: set_extra_try_arguments 20:06:15 INFO - [mozharness: 2016-10-11 03:06:15.530849Z] Finished download-and-extract step (success) 20:06:15 INFO - [mozharness: 2016-10-11 03:06:15.531076Z] Running populate-webroot step. 20:06:15 INFO - Running pre-action listener: _resource_record_pre_action 20:06:15 INFO - Running main action method: populate_webroot 20:06:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:15 INFO - '--tppagecycles', 20:06:15 INFO - '7'], 20:06:15 INFO - 'tests': ['tsvgm']}}, 20:06:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['damp', 'tps']}, 20:06:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'tests': ['damp', 'tps']}, 20:06:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['dromaeo_dom']}, 20:06:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['basic_compositor_video']}, 20:06:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['a11yr', 20:06:15 INFO - 'ts_paint', 20:06:15 INFO - 'tpaint', 20:06:15 INFO - 'sessionrestore', 20:06:15 INFO - 'sessionrestore_no_auto_restore', 20:06:15 INFO - 'tabpaint']}, 20:06:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tsvgx', 20:06:15 INFO - 'tsvgr_opacity', 20:06:15 INFO - 'tart', 20:06:15 INFO - 'tscrollx', 20:06:15 INFO - 'cart']}, 20:06:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:15 INFO - 'tsvgr_opacity', 20:06:15 INFO - 'tart', 20:06:15 INFO - 'tscrollx', 20:06:15 INFO - 'cart']}, 20:06:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s'], 20:06:15 INFO - 'tests': ['tp5o']}, 20:06:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'tests': ['tp5o']}, 20:06:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--disable-e10s', 20:06:15 INFO - '--xperf_path', 20:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:15 INFO - 'tests': ['tp5n']}, 20:06:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:15 INFO - 'talos_options': ['--xperf_path', 20:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:15 INFO - 'tests': ['tp5n']}}, 20:06:15 INFO - 'talos.zip': {'path': '', 20:06:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:15 INFO - Running post-action listener: _resource_record_post_action 20:06:15 INFO - [mozharness: 2016-10-11 03:06:15.552029Z] Finished populate-webroot step (success) 20:06:15 INFO - [mozharness: 2016-10-11 03:06:15.552117Z] Running create-virtualenv step. 20:06:15 INFO - Running pre-action listener: _resource_record_pre_action 20:06:15 INFO - Running main action method: create_virtualenv 20:06:15 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:15 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 20:06:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:15 INFO - Using real prefix '/usr' 20:06:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:18 INFO - Installing pip.................done. 20:06:18 INFO - Return code: 0 20:06:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:06:18 INFO - Reading from file tmpfile_stdout 20:06:18 INFO - Output received: 20:06:18 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) 20:06:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:18 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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:18 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 20:06:18 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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:18 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 20:06:18 INFO - Cleaning up... 20:06:18 INFO - Return code: 0 20:06:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:18 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')]} 20:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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')]} 20:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:18 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:18 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 20:06:18 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 20:06:18 INFO - Using env: {'DISPLAY': ':0', 20:06:18 INFO - 'HOME': '/home/cltbld', 20:06:18 INFO - 'LANG': 'en_US.UTF-8', 20:06:18 INFO - 'LANGUAGE': 'en_US:en', 20:06:18 INFO - 'LOGNAME': 'cltbld', 20:06:18 INFO - 'MAIL': '/var/mail/cltbld', 20:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:18 INFO - 'MOZ_NO_REMOTE': '1', 20:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:18 INFO - 'NO_EM_RESTART': '1', 20:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:18 INFO - 'PWD': '/builds/slave/test', 20:06:18 INFO - 'SHELL': '/bin/bash', 20:06:18 INFO - 'SHLVL': '1', 20:06:18 INFO - 'TERM': 'linux', 20:06:18 INFO - 'TMOUT': '86400', 20:06:18 INFO - 'USER': 'cltbld', 20:06:18 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:18 INFO - '_': '/tools/buildbot/bin/python'} 20:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:19 INFO - Downloading/unpacking psutil>=3.1.1 20:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:21 INFO - Installing collected packages: psutil 20:06:21 INFO - Running setup.py install for psutil 20:06:21 INFO - building 'psutil._psutil_linux' extension 20:06:21 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 20:06:22 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 20:06:22 INFO - building 'psutil._psutil_posix' extension 20:06:22 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 20:06:22 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 20:06:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:22 INFO - Successfully installed psutil 20:06:22 INFO - Cleaning up... 20:06:22 INFO - Return code: 0 20:06:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:06:22 INFO - Using env: {'DISPLAY': ':0', 20:06:22 INFO - 'HOME': '/home/cltbld', 20:06:22 INFO - 'LANG': 'en_US.UTF-8', 20:06:22 INFO - 'LANGUAGE': 'en_US:en', 20:06:22 INFO - 'LOGNAME': 'cltbld', 20:06:22 INFO - 'MAIL': '/var/mail/cltbld', 20:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:22 INFO - 'MOZ_NO_REMOTE': '1', 20:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:22 INFO - 'NO_EM_RESTART': '1', 20:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:22 INFO - 'PWD': '/builds/slave/test', 20:06:22 INFO - 'SHELL': '/bin/bash', 20:06:22 INFO - 'SHLVL': '1', 20:06:22 INFO - 'TERM': 'linux', 20:06:22 INFO - 'TMOUT': '86400', 20:06:22 INFO - 'USER': 'cltbld', 20:06:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:22 INFO - '_': '/tools/buildbot/bin/python'} 20:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:24 INFO - Installing collected packages: mozsystemmonitor 20:06:24 INFO - Running setup.py install for mozsystemmonitor 20:06:24 INFO - Successfully installed mozsystemmonitor 20:06:24 INFO - Cleaning up... 20:06:24 INFO - Return code: 0 20:06:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:24 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')]} 20:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:24 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')]} 20:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:24 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:24 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 20:06:24 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 20:06:24 INFO - Using env: {'DISPLAY': ':0', 20:06:24 INFO - 'HOME': '/home/cltbld', 20:06:24 INFO - 'LANG': 'en_US.UTF-8', 20:06:24 INFO - 'LANGUAGE': 'en_US:en', 20:06:24 INFO - 'LOGNAME': 'cltbld', 20:06:24 INFO - 'MAIL': '/var/mail/cltbld', 20:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:24 INFO - 'MOZ_NO_REMOTE': '1', 20:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:24 INFO - 'NO_EM_RESTART': '1', 20:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:24 INFO - 'PWD': '/builds/slave/test', 20:06:24 INFO - 'SHELL': '/bin/bash', 20:06:24 INFO - 'SHLVL': '1', 20:06:24 INFO - 'TERM': 'linux', 20:06:24 INFO - 'TMOUT': '86400', 20:06:24 INFO - 'USER': 'cltbld', 20:06:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:24 INFO - '_': '/tools/buildbot/bin/python'} 20:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:25 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:27 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:27 INFO - warning: no files found matching '*.txt' 20:06:27 INFO - no previously-included directories found matching 'build' 20:06:27 INFO - no previously-included directories found matching 'dist' 20:06:27 INFO - no previously-included directories found matching '.git*' 20:06:27 INFO - Installing collected packages: jsonschema, functools32 20:06:27 INFO - Running setup.py install for functools32 20:06:27 INFO - warning: no files found matching '*.txt' 20:06:27 INFO - no previously-included directories found matching 'build' 20:06:27 INFO - no previously-included directories found matching 'dist' 20:06:27 INFO - no previously-included directories found matching '.git*' 20:06:27 INFO - Successfully installed jsonschema functools32 20:06:27 INFO - Cleaning up... 20:06:27 INFO - Return code: 0 20:06:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06:27 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')]} 20:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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')]} 20:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:27 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 20:06:27 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 20:06:27 INFO - Using env: {'DISPLAY': ':0', 20:06:27 INFO - 'HOME': '/home/cltbld', 20:06:27 INFO - 'LANG': 'en_US.UTF-8', 20:06:27 INFO - 'LANGUAGE': 'en_US:en', 20:06:27 INFO - 'LOGNAME': 'cltbld', 20:06:27 INFO - 'MAIL': '/var/mail/cltbld', 20:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:27 INFO - 'MOZ_NO_REMOTE': '1', 20:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:27 INFO - 'NO_EM_RESTART': '1', 20:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:27 INFO - 'PWD': '/builds/slave/test', 20:06:27 INFO - 'SHELL': '/bin/bash', 20:06:27 INFO - 'SHLVL': '1', 20:06:27 INFO - 'TERM': 'linux', 20:06:27 INFO - 'TMOUT': '86400', 20:06:27 INFO - 'USER': 'cltbld', 20:06:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:27 INFO - '_': '/tools/buildbot/bin/python'} 20:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:27 INFO - Cleaning up... 20:06:27 INFO - Return code: 0 20:06:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:27 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')]} 20:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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')]} 20:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:27 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:27 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 20:06:27 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 20:06:27 INFO - Using env: {'DISPLAY': ':0', 20:06:27 INFO - 'HOME': '/home/cltbld', 20:06:27 INFO - 'LANG': 'en_US.UTF-8', 20:06:27 INFO - 'LANGUAGE': 'en_US:en', 20:06:27 INFO - 'LOGNAME': 'cltbld', 20:06:27 INFO - 'MAIL': '/var/mail/cltbld', 20:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:27 INFO - 'MOZ_NO_REMOTE': '1', 20:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:27 INFO - 'NO_EM_RESTART': '1', 20:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:27 INFO - 'PWD': '/builds/slave/test', 20:06:27 INFO - 'SHELL': '/bin/bash', 20:06:27 INFO - 'SHLVL': '1', 20:06:27 INFO - 'TERM': 'linux', 20:06:27 INFO - 'TMOUT': '86400', 20:06:27 INFO - 'USER': 'cltbld', 20:06:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:27 INFO - '_': '/tools/buildbot/bin/python'} 20:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:28 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:30 INFO - Downloading docopt-0.6.1.tar.gz 20:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:30 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:30 INFO - Running setup.py install for blobuploader 20:06:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:30 INFO - Running setup.py install for requests 20:06:31 INFO - Running setup.py install for docopt 20:06:31 INFO - Successfully installed blobuploader requests docopt 20:06:31 INFO - Cleaning up... 20:06:31 INFO - Return code: 0 20:06:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:31 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')]} 20:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:31 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')]} 20:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:31 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:31 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 20:06:31 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 20:06:31 INFO - Using env: {'DISPLAY': ':0', 20:06:31 INFO - 'HOME': '/home/cltbld', 20:06:31 INFO - 'LANG': 'en_US.UTF-8', 20:06:31 INFO - 'LANGUAGE': 'en_US:en', 20:06:31 INFO - 'LOGNAME': 'cltbld', 20:06:31 INFO - 'MAIL': '/var/mail/cltbld', 20:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:31 INFO - 'MOZ_NO_REMOTE': '1', 20:06:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:31 INFO - 'NO_EM_RESTART': '1', 20:06:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:31 INFO - 'PWD': '/builds/slave/test', 20:06:31 INFO - 'SHELL': '/bin/bash', 20:06:31 INFO - 'SHLVL': '1', 20:06:31 INFO - 'TERM': 'linux', 20:06:31 INFO - 'TMOUT': '86400', 20:06:31 INFO - 'USER': 'cltbld', 20:06:31 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:31 INFO - '_': '/tools/buildbot/bin/python'} 20:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:31 INFO - Running setup.py (path:/tmp/pip-nt25WP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:31 INFO - Running setup.py (path:/tmp/pip-lCC4S7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:31 INFO - Running setup.py (path:/tmp/pip-JoGAjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:31 INFO - Running setup.py (path:/tmp/pip-G8zOFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:31 INFO - Running setup.py (path:/tmp/pip-WDKduo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:31 INFO - Running setup.py (path:/tmp/pip-5PGe5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:32 INFO - Running setup.py (path:/tmp/pip-zGLXHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:32 INFO - Running setup.py (path:/tmp/pip-T3z3Cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:32 INFO - Running setup.py (path:/tmp/pip-qr_tPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:32 INFO - Running setup.py (path:/tmp/pip-sCmcMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:32 INFO - Running setup.py (path:/tmp/pip-Aq2q1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:32 INFO - Running setup.py (path:/tmp/pip-d5R64o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:32 INFO - Running setup.py (path:/tmp/pip-_GyKrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:32 INFO - Running setup.py (path:/tmp/pip-3JO00K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:32 INFO - Running setup.py (path:/tmp/pip-yiHfgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:32 INFO - Running setup.py (path:/tmp/pip-YymOrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:32 INFO - Running setup.py (path:/tmp/pip-oPhEFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:32 INFO - Running setup.py install for manifestparser 20:06:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:32 INFO - Running setup.py install for mozcrash 20:06:33 INFO - Running setup.py install for mozdebug 20:06:33 INFO - Running setup.py install for mozdevice 20:06:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for mozfile 20:06:33 INFO - Running setup.py install for mozhttpd 20:06:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for mozinfo 20:06:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for mozInstall 20:06:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for mozleak 20:06:33 INFO - Running setup.py install for mozlog 20:06:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for moznetwork 20:06:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:33 INFO - Running setup.py install for mozprocess 20:06:34 INFO - Running setup.py install for mozprofile 20:06:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:34 INFO - Running setup.py install for mozrunner 20:06:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:34 INFO - Running setup.py install for mozscreenshot 20:06:34 INFO - Running setup.py install for moztest 20:06:34 INFO - Running setup.py install for mozversion 20:06:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:34 INFO - Cleaning up... 20:06:34 INFO - Return code: 0 20:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:34 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')]} 20:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:34 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')]} 20:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:34 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:34 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 20:06:34 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 20:06:34 INFO - Using env: {'DISPLAY': ':0', 20:06:34 INFO - 'HOME': '/home/cltbld', 20:06:34 INFO - 'LANG': 'en_US.UTF-8', 20:06:34 INFO - 'LANGUAGE': 'en_US:en', 20:06:34 INFO - 'LOGNAME': 'cltbld', 20:06:34 INFO - 'MAIL': '/var/mail/cltbld', 20:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:34 INFO - 'MOZ_NO_REMOTE': '1', 20:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:34 INFO - 'NO_EM_RESTART': '1', 20:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:34 INFO - 'PWD': '/builds/slave/test', 20:06:34 INFO - 'SHELL': '/bin/bash', 20:06:34 INFO - 'SHLVL': '1', 20:06:34 INFO - 'TERM': 'linux', 20:06:34 INFO - 'TMOUT': '86400', 20:06:34 INFO - 'USER': 'cltbld', 20:06:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:34 INFO - '_': '/tools/buildbot/bin/python'} 20:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:34 INFO - Running setup.py (path:/tmp/pip-Ln45q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:34 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)) 20:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:34 INFO - Running setup.py (path:/tmp/pip-uqyhGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:35 INFO - Running setup.py (path:/tmp/pip-V40eBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:35 INFO - Running setup.py (path:/tmp/pip-JoMv9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:35 INFO - Running setup.py (path:/tmp/pip-yPk6fS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:35 INFO - Running setup.py (path:/tmp/pip-bTkYQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:35 INFO - Running setup.py (path:/tmp/pip-ywZ4Fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:35 INFO - Running setup.py (path:/tmp/pip-gj2RZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:35 INFO - Running setup.py (path:/tmp/pip-b4SZas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:35 INFO - Running setup.py (path:/tmp/pip-lXpWu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:35 INFO - Running setup.py (path:/tmp/pip-8XOQII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:35 INFO - Running setup.py (path:/tmp/pip-2jJ8ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:35 INFO - Running setup.py (path:/tmp/pip-Defjyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:35 INFO - Running setup.py (path:/tmp/pip-6qTqiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:35 INFO - Running setup.py (path:/tmp/pip-Ku_S9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:35 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)) 20:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:35 INFO - Running setup.py (path:/tmp/pip-wr3Mph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:36 INFO - Running setup.py (path:/tmp/pip-N4scAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:06:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:06:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:37 INFO - Downloading blessings-1.6.tar.gz 20:06:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:38 INFO - Installing collected packages: blessings 20:06:38 INFO - Running setup.py install for blessings 20:06:38 INFO - Successfully installed blessings 20:06:38 INFO - Cleaning up... 20:06:38 INFO - Return code: 0 20:06:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:38 INFO - Reading from file tmpfile_stdout 20:06:38 INFO - Current package versions: 20:06:38 INFO - argparse == 1.2.1 20:06:38 INFO - blessings == 1.6 20:06:38 INFO - blobuploader == 1.2.4 20:06:38 INFO - docopt == 0.6.1 20:06:38 INFO - functools32 == 3.2.3-2 20:06:38 INFO - jsonschema == 2.5.1 20:06:38 INFO - manifestparser == 1.1 20:06:38 INFO - mozInstall == 1.12 20:06:38 INFO - mozcrash == 0.17 20:06:38 INFO - mozdebug == 0.1 20:06:38 INFO - mozdevice == 0.48 20:06:38 INFO - mozfile == 1.2 20:06:38 INFO - mozhttpd == 0.7 20:06:38 INFO - mozinfo == 0.9 20:06:38 INFO - mozleak == 0.1 20:06:38 INFO - mozlog == 3.4 20:06:38 INFO - moznetwork == 0.27 20:06:38 INFO - mozprocess == 0.23 20:06:38 INFO - mozprofile == 0.28 20:06:38 INFO - mozrunner == 6.12 20:06:38 INFO - mozscreenshot == 0.1 20:06:38 INFO - mozsystemmonitor == 0.3 20:06:38 INFO - moztest == 0.7 20:06:38 INFO - mozversion == 1.4 20:06:38 INFO - psutil == 3.1.1 20:06:38 INFO - requests == 1.2.3 20:06:38 INFO - wsgiref == 0.1.2 20:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:38 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 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06:38 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 20:06:38 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 20:06:38 INFO - Using env: {'DISPLAY': ':0', 20:06:38 INFO - 'HOME': '/home/cltbld', 20:06:38 INFO - 'LANG': 'en_US.UTF-8', 20:06:38 INFO - 'LANGUAGE': 'en_US:en', 20:06:38 INFO - 'LOGNAME': 'cltbld', 20:06:38 INFO - 'MAIL': '/var/mail/cltbld', 20:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:38 INFO - 'MOZ_NO_REMOTE': '1', 20:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:38 INFO - 'NO_EM_RESTART': '1', 20:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:38 INFO - 'PWD': '/builds/slave/test', 20:06:38 INFO - 'SHELL': '/bin/bash', 20:06:38 INFO - 'SHLVL': '1', 20:06:38 INFO - 'TERM': 'linux', 20:06:38 INFO - 'TMOUT': '86400', 20:06:38 INFO - 'USER': 'cltbld', 20:06:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:38 INFO - '_': '/tools/buildbot/bin/python'} 20:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 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)) 20:06:38 INFO - Cleaning up... 20:06:38 INFO - Return code: 0 20:06:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2ecf77f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf7c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1049ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, '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': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', '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 20:06: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', 'jsonschema'] in /builds/slave/test/build 20:06: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 jsonschema 20:06:38 INFO - Using env: {'DISPLAY': ':0', 20:06:38 INFO - 'HOME': '/home/cltbld', 20:06:38 INFO - 'LANG': 'en_US.UTF-8', 20:06:38 INFO - 'LANGUAGE': 'en_US:en', 20:06:38 INFO - 'LOGNAME': 'cltbld', 20:06:38 INFO - 'MAIL': '/var/mail/cltbld', 20:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:38 INFO - 'MOZ_NO_REMOTE': '1', 20:06:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:38 INFO - 'NO_EM_RESTART': '1', 20:06:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:38 INFO - 'PWD': '/builds/slave/test', 20:06:38 INFO - 'SHELL': '/bin/bash', 20:06:38 INFO - 'SHLVL': '1', 20:06:38 INFO - 'TERM': 'linux', 20:06:38 INFO - 'TMOUT': '86400', 20:06:38 INFO - 'USER': 'cltbld', 20:06:38 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:38 INFO - '_': '/tools/buildbot/bin/python'} 20:06:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:38 INFO - Cleaning up... 20:06:39 INFO - Return code: 0 20:06:39 INFO - Running post-action listener: _resource_record_post_action 20:06:39 INFO - Running post-action listener: _start_resource_monitoring 20:06:39 INFO - Starting resource monitoring. 20:06:39 INFO - [mozharness: 2016-10-11 03:06:39.041165Z] Finished create-virtualenv step (success) 20:06:39 INFO - [mozharness: 2016-10-11 03:06:39.042141Z] Running install step. 20:06:39 INFO - Running pre-action listener: _resource_record_pre_action 20:06:39 INFO - Running main action method: install 20:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:39 INFO - Reading from file tmpfile_stdout 20:06:39 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:39 INFO - Reading from file tmpfile_stdout 20:06:39 INFO - Output received: 20:06:39 INFO - Usage: mozinstall [options] installer 20:06:39 INFO - Options: 20:06:39 INFO - -h, --help show this help message and exit 20:06:39 INFO - -d DEST, --destination=DEST 20:06:39 INFO - Directory to install application into. [default: 20:06:39 INFO - "/builds/slave/test"] 20:06:39 INFO - --app=APP Application being installed. [default: firefox] 20:06:39 INFO - mkdir: /builds/slave/test/build/application 20:06:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:06:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:06:55 INFO - Reading from file tmpfile_stdout 20:06:55 INFO - Output received: 20:06:55 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:55 INFO - Running post-action listener: _resource_record_post_action 20:06:55 INFO - [mozharness: 2016-10-11 03:06:55.503981Z] Finished install step (success) 20:06:55 INFO - [mozharness: 2016-10-11 03:06:55.504186Z] Running run-tests step. 20:06:55 INFO - Running pre-action listener: _resource_record_pre_action 20:06:55 INFO - Running main action method: run_tests 20:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:55 INFO - Python 2.7.3 20:06:55 INFO - Return code: 0 20:06:55 INFO - grabbing minidump binary from tooltool 20:06:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:55 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 0x1046f60>, '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 0x1047d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10481d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:55 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 20:06:55 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 20:06:55 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 20:06:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:56 INFO - Return code: 0 20:06:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 20:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 20:06:56 INFO - Using env: {'DISPLAY': ':0', 20:06:56 INFO - 'HOME': '/home/cltbld', 20:06:56 INFO - 'LANG': 'en_US.UTF-8', 20:06:56 INFO - 'LANGUAGE': 'en_US:en', 20:06:56 INFO - 'LOGNAME': 'cltbld', 20:06:56 INFO - 'MAIL': '/var/mail/cltbld', 20:06:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:56 INFO - 'MOZ_NO_REMOTE': '1', 20:06:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:56 INFO - 'NO_EM_RESTART': '1', 20:06:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:56 INFO - 'PWD': '/builds/slave/test', 20:06:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:56 INFO - 'SHELL': '/bin/bash', 20:06:56 INFO - 'SHLVL': '1', 20:06:56 INFO - 'TERM': 'linux', 20:06:56 INFO - 'TMOUT': '86400', 20:06:56 INFO - 'USER': 'cltbld', 20:06:56 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190', 20:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:56 INFO - '_': '/tools/buildbot/bin/python'} 20:06:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 20:06:56 INFO - mozversion application_buildid: 20161010191246 20:06:56 INFO - mozversion application_changeset: 723c2e894079d0c870a1b78679f971c7a1d3d31f 20:06:56 INFO - mozversion application_display_name: Nightly 20:06:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:56 INFO - mozversion application_name: Firefox 20:06:56 INFO - mozversion application_remotingname: firefox 20:06:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:06:56 INFO - mozversion application_vendor: Mozilla 20:06:56 INFO - mozversion application_version: 52.0a1 20:06:56 INFO - mozversion platform_buildid: 20161010191246 20:06:56 INFO - mozversion platform_changeset: 723c2e894079d0c870a1b78679f971c7a1d3d31f 20:06:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:06:56 INFO - mozversion platform_version: 52.0a1 20:06:56 INFO - using testdate: 1476155216 20:06:56 INFO - actual date: 1476155216 20:06:56 INFO - starting webserver on 'localhost:55896' 20:06:56 INFO - SUITE-START | Running 2 tests 20:06:56 INFO - TEST-START | dromaeo_css 20:06:56 INFO - operating with platform_type : linux_ 20:06:56 INFO - Initialising browser for dromaeo_css test... 20:06:56 INFO - TEST-INFO | started process 3333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4mghF/profile http://localhost:55896/getInfo.html) 20:07:04 INFO - PROCESS | 3333 | __metrics Screen width/height:1600/1200 20:07:04 INFO - PROCESS | 3333 | colorDepth:24 20:07:04 INFO - PROCESS | 3333 | Browser inner width/height: 1024/697 20:07:04 INFO - PROCESS | 3333 | __metrics 20:07:05 INFO - PROCESS | 3333 | 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" 20:07:05 INFO - PROCESS | 3333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:07:05 INFO - PROCESS | 3333 | console.error: PushService: 20:07:05 INFO - PROCESS | 3333 | stateChangeProcessEnqueue: Error transitioning state 20:07:05 INFO - PROCESS | 3333 | UnknownError 20:07:06 INFO - TEST-INFO | 3333: exit 0 20:07:06 INFO - Browser initialized. 20:07:06 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:06 INFO - TEST-INFO | started process 3419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW4mghF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:18 INFO - PROCESS | 3419 | RSS: Main: 175038464 20:07:18 INFO - PROCESS | 3419 | 20:08:09 INFO - PROCESS | 3419 | 1476155289752 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] 20:10:24 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:55896/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55896/tests/dromaeo/cssquery-ext.html) 20:10:25 INFO - PROCESS | 3419 | RSS: Main: 289681408 20:10:25 INFO - PROCESS | 3419 | 20:13:28 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:55896/tests/dromaeo/cssquery-ext.html (next: http://localhost:55896/tests/dromaeo/cssquery-jquery.html) 20:13:28 INFO - PROCESS | 3419 | RSS: Main: 280039424 20:13:28 INFO - PROCESS | 3419 | 20:16:31 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:55896/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55896/tests/dromaeo/cssquery-mootools.html) 20:16:31 INFO - PROCESS | 3419 | RSS: Main: 278134784 20:16:31 INFO - PROCESS | 3419 | 20:19:33 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:55896/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55896/tests/dromaeo/cssquery-prototype.html) 20:19:34 INFO - PROCESS | 3419 | RSS: Main: 220450816 20:19:34 INFO - PROCESS | 3419 | 20:22:37 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:55896/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55896/tests/dromaeo/cssquery-yui.html) 20:22:38 INFO - PROCESS | 3419 | RSS: Main: 219512832 20:22:38 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:55896/tests/dromaeo/cssquery-yui.html (next: http://localhost:55896/tests/dromaeo/cssquery-dojo.html) 20:25:41 INFO - PROCESS | 3419 | RSS: Main: 309526528 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | __start_tp_report 20:25:41 INFO - PROCESS | 3419 | _x_x_mozilla_page_load 20:25:41 INFO - PROCESS | 3419 | _x_x_mozilla_page_load_details 20:25:41 INFO - PROCESS | 3419 | |i|pagename|runs| 20:25:41 INFO - PROCESS | 3419 | |0;dojo.html;2581.1998280533035;2599.6620439342882;2607.530644483992;2639.036751585672;2653.854038027908;4544.363789069533;4626.236670949289;4751.40607424072;4769.618430525563;4789.952100478994;4655.930161047587;4664;4675.532446755323;4697.318888761128;4792.281157826328;4293.506246781613;4317.244482215616;4330.177266319405;4343.565643435647;4346.434963454746;4298.527162012176;4367.934480982788;4381.145676593065;4403.383526306319;4454.465464144308;4347;4383.539728328527;4396.516383197845;4398.120375924827;4441.689081764278;4218.78906054696;4246.681498887565;4275.551067137968;4307.5261721210645;4330.935035974463;4218.0720241546815;4221.409002739619;4243.363495475673;4325.048489332374;4388.253996820548;4669.486356500816;4672.672912896064;4675.696079754805;4706.3411122442885;4755.809767609291;4865.537773911473;4904.681195722266;4982.476839931791;5016.799328026875;5024.472430394792;5046.798128074873;5081.568066714333;5085.618578606619;5087.694738315713;5137.126688462933;4691.413573303337;4715.7877895494785;4728.0543891221205;4730.479647238801;4740.715557066587;4996.90006199874;5018.523240292239;5022.874428139326;5162.354705661793;5237.5548078413;4874.902501950012;4889.168841296988;4952.653314268039;4969.105560998983;4997.600191984632;5045.041442125985;5069.847904562869;5108.106081435734;5131.025105229995;5131.2559678846355;4996.750162491933;5011.548960593491;5016.54851063406;5073.1122053640465;5081.314022606901;4795.688280261772;4857.95142048575;4988.625853061035;5006.549410553068;5008.424031236382;4208.137331846964;4215.620594146541;4265.125649241898;4266.8293268269545;4336.76147811867;3717.683996860297;3722.4602432647116;3726.4596633488536;3764.849406023783;3772.660460558563;4291.957080429156;4293.849715259951;4296.3555466680245;4316.525182230015;4348.2390581648715;4927.507249275044;4977.576905962961;4988.102141614471;5016.54851063406;5021.774020169101;4286.61420472159;4291.527931927485;4291.957080429156;4310.181065597527;4339.088791353851;4513.796879140446;4522.886927826765;4529.139463501924;4530.6602004849765;4586.174488592085;4601.723896566216;4667.62658987287;4670.556297151765;4706.835260765857;4761.619070474285;5044.218146187347;5047.268146118866;5050.671706339223;5087.491250874883;5087.821926232564;4657.510961349009;4675.672702910763;4691.835785747482;4708.246680531099;4777.21176005969;4829.372181616367;4887.706737595756;4930.7534623267975;4947.604191664586;5037.722925239147;5020.924686129784;5077.339945807022;5083.440821509557;5138.203578445347;5144.845654630367;4873.122837889214;4877.780499877443;4881.511848815232;4883.389576302962;4944.75276236194;4754.500777418321;4815.15734746411;4859.975700121477;4878.0975519529;4937.654364194472;4663.603593694574;4695.906081878412;4699.365585646031;4710.952890471051;4763.1426343258545;4838.903221935471;4871.8294859679745;4881.8535443936735;4881.9023619528125;4944.3572335596145;4639.466461356988;4661.230896902109;4683;4691.249400095969;4780.163471392562 20:25:41 INFO - PROCESS | 3419 | |1;ext.html;551.3383939272873;559.697763207868;561.6152935239364;563.3690266901071;566.1112054075103;27618.309542261453;38549.229015419674;39563.802180989056;39689.801550992204;42749.57250427495;40096.39855402164;40328.337615852965;40477.19045619086;40495.19009619806;40544.391834122514;7547.283008114234;7685.654145563435;7686.385089192851;7698.461107722462;7698.884516732225;7608.885866712004;7700.653470593808;7708;7708.49894756839;7711.807204819868;7701.8074548136465;7742.535447873118;7752.3410510106705;7753.961230193841;7756.573388463632;7684.07791065073;7691.653875575613;7702.191269916634;7705.576193309365;7706.152323244411;7527.059117610299;7538;7591.696332146707;7622.733204337877;7622.8475430491635;36889.44665830015;37130.8143459281;37166;37244.627553724386;37271.25457490835;3177.5710279112254;3192.6488086310487;3200.9679903201136;3376.324735052999;3402.42158832999;27890.151928089384;28440.857795711097;28653.856730716423;28702.569461458093;28900.566491502643;3429;3459.100633835196;3668.8715894943816;3680.0615842959874;3681.742278040538;221345;223254;223522;223596.3482556238;224204;49532.53272270979;49780.75109624501;49887.50112498901;49930.50069499331;50122.498775012515;53221.33893305319;53228.46771532235;53299;53368.73315633397;53472.19791703128;11753.236039657395;11818.231814932002;11903.583374581847;11926.46330915111;11926.701832454259;9102.317326200562;9154.31342649304;9159.038300978435;9164;9168.541572921327;13627.727445451035;15813.209339532978;15849;15915.681686366439;16060.67878642444;4898.24077268024;5197.402298735618;5485.588580856372;5499.807506737245;5587.32952045749;707.1649070661728;756.8826831841073;839.9454035487673;888.8266787976412;989.8267803134422;27235;27614.44771104567;27659;27746.86023159864;27907.44185116327;929.5120061967522;932.5523748600709;945.4705364995486;974.5955428497094;997.6907158780801;14468.131912085099;14803.407863685332;14839.554813355617;14991;15133.243337833064;309790;507778;523465;523558;523703;47658.5234147661;48146.27780583294;48157.27764083542;48174;48182.75908620434;1058.312097136852;1096.797092537867;1177.6290468502393;1200.8138738495547;1202.9278243305255;25433.364165896;28928.855355723088;29293;30397.544036839907;30500.237494062825;44786;45517.54482455133;45523.54476455193;45754;45754.31368529408;294747;294899;295038;295566;296052;24338;24500.387490312885;24845.279396914528;24928.62607060932;25356.366090847878;40642.59357406506;40964.38553421761;41051.794741026104;41090.58909410868;41124.588754112076;34561.48157777686;34634.82682586571;34947;35034.29931401409;35259.82370088133;34437.48343774795;34911.65088349186;34964.8322093965;35450.468242976895;35459;29783.255418614706;30005.549916751705;30542.694573053985;32565;32725;29060.418791624474;31077.689223107478;31447.21381965469;31777.68222317747;31800.84099579487;24397.634035489125;24673.383165421008;25033.249002529952;25083.372915676526;25193.748062519142 20:25:41 INFO - PROCESS | 3419 | |2;jquery.html;358.446200620042;364.0752488678756;367.9871204507843;370.25209077663106;383.75247965062533;15359.769603455943;16656.417025404113;16727.247273872676;16862.662746745056;16889.493315200565;15788.210589470538;15971.84380108685;16223.594410139753;16250;16396;4831.106245344605;5070.366204224472;5073.188289873621;5102.974485127569;5133.794648214067;3591.2637909228674;3773.924521509568;5055.696658200502;5652.971735141318;5918.082697181943;6050.27396712393;6087;6087.117367981662;6090.360512146227;6094.238220222473;5828.358880523139;5962.463378295931;5973.372795856416;5986.551008674367;5987;5083.872903177413;5237;5238.816641417532;5246.081935661244;5248.448912864133;16050.518484445485;16184;16223.26995285215;16265;18811.435656930313;1864.254298280685;1871.4479228627588;1947.6688962876344;2084.8749075055393;2413.239829453734;8839.558022098869;12336;12644.367781610883;13032.152910060911;13630.318484075855;1709.7520859475305;1744.084355713248;1750.9124543772887;1788.8926664400178;1862.5157459060606;59372;67841.66079169622;68419.65790171018;68561.31438685599;69364.30635693629;9539.09378609031;9770.477159375754;9877.16044136242;10011.499425028866;10014.849777253346;13488.325583720774;13510.986675999142;13529.458821647024;13534.120282181626;13538.59384218475;6412.358764123644;6577.14497115372;6623.3376662333385;6638.103855979478;6760.526763126534;6002.729877155539;6036.909446358308;6090.756369745249;6187.195664563578;6206.534509911775;4320.481542214954;4333.328334108218;4342.305231162999;4404.11917616478;4427.623651989553;1509.3358922074253;1584.698907207627;1757.384915279642;1783.9018853962898;1847.159542408201;786.9488483248571;796.3430170109683;797.7327595255539;863.2964134230707;877.5831480047054;15494.07035577869;15935.362585496681;16262.593435163979;16302;16640.916795415946;816.1675091406851;825.7068740597122;835.9791005224918;856.4304737349718;872.4852337121002;8664.91335086641;9010.459372437545;9431.858522122173;9500.857487137699;9639.71080867575;328457;328926;329010;358305;370760;76955.23044769593;80616.59691701621;80734.19265807384;80776;84237.83718930652;837.0875745437625;884.7168905950163;896.2919293757989;925.3106435705308;931.9720408387759;11927.582534611247;15043.398264069314;15826.28781704803;15845.207739613204;16117.032978021356;33827.98516044523;34294.65705343014;35373.82313088418;36602.633973659926;38726.8381948542;48631.75684121557;49371.75314123406;49388.50611493839;49937.25094123519;53436;7248;7523.774286771406;7613.619319034137;7616;7650.770476885702;8233.053198882206;10836.403997779882;11105.16711246676;11360;11631.6510504685;6193;7556.962215188889;9620.663276785279;10057.597696092074;10145.9492702536;9302.95348523253;9515.571799269188;9813.754656133653;9976.351537150062;10203.84694229602;9560.28297877648;9661.565229564827;9689.22486201088;9817.509124543602;9818.558164882455;7418.56636903273;7434.219406962407;7721.575313357819;7864.331531819859;7889.5660738657625;9493.952530237304;9602.423854568748;9786.75533111678;9920;9987.001299870246 20:25:41 INFO - PROCESS | 3419 | |3;mootools.html;1334.5996201139658;1371.855955124712;1421.4527406948328;1624.1554391716315;1680.1011458869507;6526.2168539775175;6719.428848547879;7199.136103667561;7788.883166752496;7794.025746781653;7392.149902761184;7688.500247483909;7690.423218258639;7690.884636730453;7697.114831794345;2153.924612638562;2181.301983365324;2183.1922188790168;2196.593630178414;2198.8460807743463;1817.0551313317067;1882.3223639489772;2119.8304135669187;2152.773958734334;2163.4483206782247;1842.8525717942532;1860.9162587683586;1992.4122383896786;2054.1577953039255;2059.238081909688;2128.6168489671854;2128.648772952461;2129.5634394948997;2133.7866213378693;2134.5304033112766;2060.9072591733407;2105.631514484959;2105.7052012718077;2109.177420805887;2120.9257675981266;7674.693012279502;7708.152103268636;7710.807229819244;7762;7763.0684317882215;4199.559046300125;4384.4519435070615;4435.911281774379;4438.245498265303;4439.356293337481;2871.1530098620747;2927.985360073186;2982.284251779579;3000.6549246836676;3006.759459243255;898.1333013641802;949.767307009787;964.4936408385654;964.9783703141976;966.8308046091976;10289;10327.896721032768;10342.431166285927;10367.481625918674;10391.272610917238;3871.903202419962;4080.9795951020646;4136.255474014646;4228.809703563285;4241.236577416094;8845;8846.15961483658;8851.867221991675;8854.557272136368;8917.910820891837;4292.055747735493;4294;4294.763787991628;4315.6763242756915;4316.589923957219;3834.367329390675;3834.7699138051807;3837.4627552142724;3841.193349396658;3841.615838416136;3225.6129264488413;3293.950590741141;3301.224212310105;3305.801651900894;3314.6022477302877;1020.1125021231576;1029.2126523209752;1037.7353774787532;1039.3867618105355;1047.450088703437;837.8952630921135;845.6152450634946;859.8263370499349;875.3609864798606;884.3720958119678;5066.898662026812;5140.768665410065;5236.947630523722;5252;5349.170878513836;704.4786857725246;705.7071315404153;712.113418793595;748.2293237964905;760.0803028335665;3439.6216416194197;3506.2461570762407;3519.595246546629;3539.150603855056;3597.7661452005536;8708.129187081367;9017.774555636162;9057;9067.54662266884;9175.724728258163;8817.206451419275;8994.280457563511;8999.145081217273;9003.77490562728;9040.141186587263;7001.614911179934;7127.536710113826;7165.032720582654;7165.89251161233;7167.498275120692;5073.2897394365555;5111.233315002779;5146.279520867157;5173.22401639757;5302.019126461617;8340.958295208486;8474.788130296793;8582.141785821368;8607.956960215159;8645.697400590949;8564.52895090776;8645.135486451305;8740.868886966828;8755.43089699193;8777;6204.410580994799;6212.285587157354;6241.845258627169;6277.497800175884;6308.116863639002;7203.459740519586;7259.673314700745;7267.236940121211;7267.927320726725;7275.490715650066;6091.573589848668;6150.4792838469675;6233.625982441068;6270.717817698123;6359.96820015897;6460.418562329413;6491.707873145814;6510.544261901621;6525.967370163119;6535.705893234721;6041.6375017499095;6127.754889804536;6130.111133885473;6131.938680613315;6135;4508.278675411918;4512.9548704513845;4540.160070386989;4597.218472859555;4607.124646317189;4348.499922508952;4412.580804823537;4414.757188354672;4635.3278774578175;4674.462436819809 20:25:41 INFO - PROCESS | 3419 | |4;prototype.html;299.6838335555988;303.62047440699126;307.7015295163692;308.6558487286676;312.9561861339413;4830.734309612974;4838.080764654713;4852.441969173546;4883.169861123609;4908.312836202935;4822.710637361761;4865.41873890986;4871.878203044926;4888;4893.510648935105;3614.4216925291958;3721.3301605710963;3786.848526058954;3828.119532507525;3848.826802793881;3840.327942610032;3849.7690138591774;3853;3863.343231650612;3886.397608370707;3803.413678698484;3814.9427758583643;3819.9045023874487;3822.069854723361;3847.230553889219;3582.3730847101783;3699.90750231245;3749.212665340282;3811.313963486571;3828.846846126152;3370.4607262837826;3376.7467439941856;3386.646280834796;3389.7288216942584;3391.524686761267;4711.670183087185;4728.172569800271;4735.479097299294;4740.360051393087;4791.377120974286;4256.899634033412;4312.159128969852;4388.648908087345;4428.977855110736;4436.334549817521;5040.395152581677;5045.747712614391;5054.028928717803;5055.216441451544;5058.494150584949;3702.833372498244;3719.2189640175598;3723.590405055442;3730.0301921500336;3742.6257374262627;5251.291075704769;5333.6266461348105;5364.302640656729;5366.436524164946;5393.460653934614;3781.149241420658;3808.6000969897764;3813.8474461021246;3818.1981783825154;3821.522309711286;3873.2253549290253;3882.6311500407414;3888.3389823730035;3904.8090332448874;3907.296686596383;4395.450568678915;4395.494518130392;4399.626031787334;4407.118576284756;4409.889752756143;4972.7513624318635;5054.9241761373605;5060.544550990428;5069.771860266297;5085.4914508548845;1314.0341848741168;1321.1610627251764;1324.913880597758;1328.5881376773232;1330.4678128748385;811.5739236900674;836.2056046755606;870.950504641905;872.5855218771032;881.290561098322;4255.297875850512;4301.892452688708;4450.666200035011;4451.821927122944;4479.776011199427;5128.461511541309;5232.92150617741;5233;5242.7378631068295;5256.684598924076;4412.205802955499;4430.269005614037;4446.977765111218;4479.753613551221;4491.932621010687;2625.912399642289;2788.386554957906;2788.4980703473166;2789.1353680359152;2794.413173233603;4916.975415122902;4921.655484116078;4935.506449355107;4936.975315123402;4960.826371076995;5248.6588371755715;5355;5404.945950540523;5410.269613602113;5420.891582168335;4886.071646387175;4887.95112048882;4912.238603016538;4920.360353154067;4926.999999999928;5201.930860792151;5213.739313034409;5220.347456567929;5228.607854410859;5281.471852814688;4922.630802689741;5140.712382989534;5172.379314482287;5180.8137995131965;5194.8961020780125;4954.727489987941;4957.504249575014;4958.727270000185;4963.751812409438;4975;3723.255348930171;3725.1245957200576;3758.2483503298904;3774.7735135891935;3780.1494663700446;5146.382434107931;5177.8187763428095;5352.625316227983;5356.5714742821265;5360.973195133999;4991.5258050485145;5041.218611115283;5044.621653375938;5045.268436076822;5059.645824792229;5078.339815823919;5086.949130508796;5087.949120508748;5088.109580823415;5112.821051263188;4714.245720684674;4940.407151141742;4973.607389930825;4990.47600002009;4999.250112483157;4828.734419606955;4877.829275975324;4973.751312434436;5090.312807771052;5096.694198348111;4923.187674033744;4942.802287908444;4947.208446648519;4983.576396006235;4999.575036121971 20:25:41 INFO - PROCESS | 3419 | |5;yui.html;650.6779144323559;657.7599176300652;678.9864202715949;721.5021635071801;744.2074190986599;13288.46846126155;14271.928640356784;14285.428582856699;14309.069910455826;14325.78511322331;13259.734805303888;13319.33403329832;13346.733065338713;13370.264635445046;13409.731805363886;607.3926073926074;622.925248970122;748.1022772672801;760.9239076092401;772.9768106956773;776.4758787818229;783.3811289081647;785.1089013969129;785.2265518464308;785.2657764989724;825.0800357601262;825.471698113208;826.450410477032;826.7354446577098;826.7809030606863;646.3342756960315;661.9801405957829;778.7975126467103;799.5282783157965;818.1818181818181;595.7944509144338;595.803384882992;596.1326270276737;596.2665920917252;596.3976383852297;11939.522419103225;11984.64046078619;12012;12043.397830108546;12094.213876098114;12159.51361945521;12517.43671534783;12538.122331436804;12924.806127908088;13064.346782660828;11309.313053235257;11485.368304743235;11551.711207219887;11707.239029463057;11791.764164716744;3938.5273767147837;3947.1513624570566;4018.6985976051915;4147.39862719907;4181.853635122756;61907;62899.37100628981;63566.68216658934;63583.68208158976;63640.36359636391;9745.171660408803;9889.258305627107;9973.950130249303;10036.146927511098;10156.796864062677;17323.56691082733;19057.809421905604;19133.8086619132;19191.80808191928;19344.226230950604;6862.519623626298;6943.062686537354;6947.7220911162985;7049.330313620198;7331.486795924234;3624.3838547447;3671.761335513183;3671.7980511071614;3682.0978860179425;3763.209725957525;2946.8379239142055;3059.1128572713665;3060.8928687496277;3067.5245336972803;3069.048594935577;482.08404032338836;488.3187952805887;494.5054945054945;503.6373810856178;512.9923051154236;505.56268827464714;538.6471860931097;611.3336463255073;621.6736213487865;638.1257676982564;8476.449030812977;8606.139386061344;8722.825543489094;8731.869021964676;8814.647414103492;502.85668584453254;538.7898719499399;567.0954827050847;576.9845072672043;642.3063091860872;3978.4430179774854;4065.2276067547073;4071.267171909085;4117.402976568381;4132.070284186094;74242.25757742353;98546.52180217303;99941.50029249807;100460.49769751105;102943;46737.29894051592;74077.62961185268;75893.62053189699;76505.61747191228;76909.61545192238;43976.56023439725;49634.255486167734;68041;70994.2900570998;71558.28441715516;8253;8397.244248017707;8957.238634716123;9067.68263110788;9079.319051071065;31908.680913190572;41058.79470602628;41232.58767412407;42280.57719422766;43659.34510982401;59434.40565594289;60406;63015.547667848354;63831.361686382545;66684;10720.839187412039;10985;11072.335659860435;11117.110631149328;11339.319640821577;12378.381080946097;12410.937945310216;12477;12772.169808962388;12826.871731282941;11652.592159274385;11884.940575297069;12359;12472;12849.935750321189;11896.22674526153;11945.283283003047;12009.699757506132;12238.449269782703;12611;11542.19204655666;11634.883651163718;11997.880021200026;12564.748705025666;12598;9426.401100544434;9624.326297159132;9772.609095636379;9818.803623927624;9820.901790982;9850.605975761177;10049.296549241482;10077.143442807443;10256.589736410759;10276 20:25:41 INFO - PROCESS | 3419 | __end_tp_report 20:25:41 INFO - PROCESS | 3419 | __start_cc_report 20:25:41 INFO - PROCESS | 3419 | _x_x_mozilla_cycle_collect,1065 20:25:41 INFO - PROCESS | 3419 | __end_cc_report 20:25:41 INFO - PROCESS | 3419 | __startTimestamp1476156341658__endTimestamp 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | ------- Summary: start ------- 20:25:41 INFO - PROCESS | 3419 | Number of tests: 6 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | [#0] dojo.html Cycles:165 Average:4631.60 Median:4715.79 stddev:483.51 (10.3%) stddev-sans-first:457.46 20:25:41 INFO - PROCESS | 3419 | Values: 2581.2 2599.7 2607.5 2639.0 2653.9 4544.4 4626.2 4751.4 4769.6 4790.0 4655.9 4664.0 4675.5 4697.3 4792.3 4293.5 4317.2 4330.2 4343.6 4346.4 4298.5 4367.9 4381.1 4403.4 4454.5 4347.0 4383.5 4396.5 4398.1 4441.7 4218.8 4246.7 4275.6 4307.5 4330.9 4218.1 4221.4 4243.4 4325.0 4388.3 4669.5 4672.7 4675.7 4706.3 4755.8 4865.5 4904.7 4982.5 5016.8 5024.5 5046.8 5081.6 5085.6 5087.7 5137.1 4691.4 4715.8 4728.1 4730.5 4740.7 4996.9 5018.5 5022.9 5162.4 5237.6 4874.9 4889.2 4952.7 4969.1 4997.6 5045.0 5069.8 5108.1 5131.0 5131.3 4996.8 5011.5 5016.5 5073.1 5081.3 4795.7 4858.0 4988.6 5006.5 5008.4 4208.1 4215.6 4265.1 4266.8 4336.8 3717.7 3722.5 3726.5 3764.8 3772.7 4292.0 4293.8 4296.4 4316.5 4348.2 4927.5 4977.6 4988.1 5016.5 5021.8 4286.6 4291.5 4292.0 4310.2 4339.1 4513.8 4522.9 4529.1 4530.7 4586.2 4601.7 4667.6 4670.6 4706.8 4761.6 5044.2 5047.3 5050.7 5087.5 5087.8 4657.5 4675.7 4691.8 4708.2 4777.2 4829.4 4887.7 4930.8 4947.6 5037.7 5020.9 5077.3 5083.4 5138.2 5144.8 4873.1 4877.8 4881.5 4883.4 4944.8 4754.5 4815.2 4860.0 4878.1 4937.7 4663.6 4695.9 4699.4 4711.0 4763.1 4838.9 4871.8 4881.9 4881.9 4944.4 4639.5 4661.2 4683.0 4691.2 4780.2 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | [#1] ext.html Cycles:180 Average:47809.30 Median:37257.94 stddev:93779.73 (251.7%) stddev-sans-first:93975.68 20:25:41 INFO - PROCESS | 3419 | Values: 551.3 559.7 561.6 563.4 566.1 27618.3 38549.2 39563.8 39689.8 42749.6 40096.4 40328.3 40477.2 40495.2 40544.4 7547.3 7685.7 7686.4 7698.5 7698.9 7608.9 7700.7 7708.0 7708.5 7711.8 7701.8 7742.5 7752.3 7754.0 7756.6 7684.1 7691.7 7702.2 7705.6 7706.2 7527.1 7538.0 7591.7 7622.7 7622.8 36889.4 37130.8 37166.0 37244.6 37271.3 3177.6 3192.6 3201.0 3376.3 3402.4 27890.2 28440.9 28653.9 28702.6 28900.6 3429.0 3459.1 3668.9 3680.1 3681.7 221345.0 223254.0 223522.0 223596.3 224204.0 49532.5 49780.8 49887.5 49930.5 50122.5 53221.3 53228.5 53299.0 53368.7 53472.2 11753.2 11818.2 11903.6 11926.5 11926.7 9102.3 9154.3 9159.0 9164.0 9168.5 13627.7 15813.2 15849.0 15915.7 16060.7 4898.2 5197.4 5485.6 5499.8 5587.3 707.2 756.9 839.9 888.8 989.8 27235.0 27614.4 27659.0 27746.9 27907.4 929.5 932.6 945.5 974.6 997.7 14468.1 14803.4 14839.6 14991.0 15133.2 309790.0 507778.0 523465.0 523558.0 523703.0 47658.5 48146.3 48157.3 48174.0 48182.8 1058.3 1096.8 1177.6 1200.8 1202.9 25433.4 28928.9 29293.0 30397.5 30500.2 44786.0 45517.5 45523.5 45754.0 45754.3 294747.0 294899.0 295038.0 295566.0 296052.0 24338.0 24500.4 24845.3 24928.6 25356.4 40642.6 40964.4 41051.8 41090.6 41124.6 34561.5 34634.8 34947.0 35034.3 35259.8 34437.5 34911.7 34964.8 35450.5 35459.0 29783.3 30005.5 30542.7 32565.0 32725.0 29060.4 31077.7 31447.2 31777.7 31800.8 24397.6 24673.4 25033.2 25083.4 25193.7 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | [#2] jquery.html Cycles:180 Average:22718.52 Median:5185.40 stddev:57142.93 (1102.0%) stddev-sans-first:57278.57 20:25:41 INFO - PROCESS | 3419 | Values: 358.4 364.1 368.0 370.3 383.8 15359.8 16656.4 16727.2 16862.7 16889.5 15788.2 15971.8 16223.6 16250.0 16396.0 4831.1 5070.4 5073.2 5103.0 5133.8 3591.3 3773.9 5055.7 5653.0 5918.1 6050.3 6087.0 6087.1 6090.4 6094.2 5828.4 5962.5 5973.4 5986.6 5987.0 5083.9 5237.0 5238.8 5246.1 5248.4 16050.5 16184.0 16223.3 16265.0 18811.4 1864.3 1871.4 1947.7 2084.9 2413.2 8839.6 12336.0 12644.4 13032.2 13630.3 1709.8 1744.1 1750.9 1788.9 1862.5 59372.0 67841.7 68419.7 68561.3 69364.3 9539.1 9770.5 9877.2 10011.5 10014.8 13488.3 13511.0 13529.5 13534.1 13538.6 6412.4 6577.1 6623.3 6638.1 6760.5 6002.7 6036.9 6090.8 6187.2 6206.5 4320.5 4333.3 4342.3 4404.1 4427.6 1509.3 1584.7 1757.4 1783.9 1847.2 786.9 796.3 797.7 863.3 877.6 15494.1 15935.4 16262.6 16302.0 16640.9 816.2 825.7 836.0 856.4 872.5 8664.9 9010.5 9431.9 9500.9 9639.7 328457.0 328926.0 329010.0 358305.0 370760.0 76955.2 80616.6 80734.2 80776.0 84237.8 837.1 884.7 896.3 925.3 932.0 11927.6 15043.4 15826.3 15845.2 16117.0 33828.0 34294.7 35373.8 36602.6 38726.8 48631.8 49371.8 49388.5 49937.3 53436.0 7248.0 7523.8 7613.6 7616.0 7650.8 8233.1 10836.4 11105.2 11360.0 11631.7 6193.0 7557.0 9620.7 10057.6 10145.9 9303.0 9515.6 9813.8 9976.4 10203.8 9560.3 9661.6 9689.2 9817.5 9818.6 7418.6 7434.2 7721.6 7864.3 7889.6 9494.0 9602.4 9786.8 9920.0 9987.0 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | [#3] mootools.html Cycles:180 Average:4936.62 Median:5205.09 stddev:2758.76 (53.0%) stddev-sans-first:2753.22 20:25:41 INFO - PROCESS | 3419 | Values: 1334.6 1371.9 1421.5 1624.2 1680.1 6526.2 6719.4 7199.1 7788.9 7794.0 7392.1 7688.5 7690.4 7690.9 7697.1 2153.9 2181.3 2183.2 2196.6 2198.8 1817.1 1882.3 2119.8 2152.8 2163.4 1842.9 1860.9 1992.4 2054.2 2059.2 2128.6 2128.6 2129.6 2133.8 2134.5 2060.9 2105.6 2105.7 2109.2 2120.9 7674.7 7708.2 7710.8 7762.0 7763.1 4199.6 4384.5 4435.9 4438.2 4439.4 2871.2 2928.0 2982.3 3000.7 3006.8 898.1 949.8 964.5 965.0 966.8 10289.0 10327.9 10342.4 10367.5 10391.3 3871.9 4081.0 4136.3 4228.8 4241.2 8845.0 8846.2 8851.9 8854.6 8917.9 4292.1 4294.0 4294.8 4315.7 4316.6 3834.4 3834.8 3837.5 3841.2 3841.6 3225.6 3294.0 3301.2 3305.8 3314.6 1020.1 1029.2 1037.7 1039.4 1047.5 837.9 845.6 859.8 875.4 884.4 5066.9 5140.8 5236.9 5252.0 5349.2 704.5 705.7 712.1 748.2 760.1 3439.6 3506.2 3519.6 3539.2 3597.8 8708.1 9017.8 9057.0 9067.5 9175.7 8817.2 8994.3 8999.1 9003.8 9040.1 7001.6 7127.5 7165.0 7165.9 7167.5 5073.3 5111.2 5146.3 5173.2 5302.0 8341.0 8474.8 8582.1 8608.0 8645.7 8564.5 8645.1 8740.9 8755.4 8777.0 6204.4 6212.3 6241.8 6277.5 6308.1 7203.5 7259.7 7267.2 7267.9 7275.5 6091.6 6150.5 6233.6 6270.7 6360.0 6460.4 6491.7 6510.5 6526.0 6535.7 6041.6 6127.8 6130.1 6131.9 6135.0 4508.3 4513.0 4540.2 4597.2 4607.1 4348.5 4412.6 4414.8 4635.3 4674.5 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | [#4] prototype.html Cycles:180 Average:4236.08 Median:4858.93 stddev:1218.41 (25.1%) stddev-sans-first:1185.46 20:25:41 INFO - PROCESS | 3419 | Values: 299.7 303.6 307.7 308.7 313.0 4830.7 4838.1 4852.4 4883.2 4908.3 4822.7 4865.4 4871.9 4888.0 4893.5 3614.4 3721.3 3786.8 3828.1 3848.8 3840.3 3849.8 3853.0 3863.3 3886.4 3803.4 3814.9 3819.9 3822.1 3847.2 3582.4 3699.9 3749.2 3811.3 3828.8 3370.5 3376.7 3386.6 3389.7 3391.5 4711.7 4728.2 4735.5 4740.4 4791.4 4256.9 4312.2 4388.6 4429.0 4436.3 5040.4 5045.7 5054.0 5055.2 5058.5 3702.8 3719.2 3723.6 3730.0 3742.6 5251.3 5333.6 5364.3 5366.4 5393.5 3781.1 3808.6 3813.8 3818.2 3821.5 3873.2 3882.6 3888.3 3904.8 3907.3 4395.5 4395.5 4399.6 4407.1 4409.9 4972.8 5054.9 5060.5 5069.8 5085.5 1314.0 1321.2 1324.9 1328.6 1330.5 811.6 836.2 871.0 872.6 881.3 4255.3 4301.9 4450.7 4451.8 4479.8 5128.5 5232.9 5233.0 5242.7 5256.7 4412.2 4430.3 4447.0 4479.8 4491.9 2625.9 2788.4 2788.5 2789.1 2794.4 4917.0 4921.7 4935.5 4937.0 4960.8 5248.7 5355.0 5404.9 5410.3 5420.9 4886.1 4888.0 4912.2 4920.4 4927.0 5201.9 5213.7 5220.3 5228.6 5281.5 4922.6 5140.7 5172.4 5180.8 5194.9 4954.7 4957.5 4958.7 4963.8 4975.0 3723.3 3725.1 3758.2 3774.8 3780.1 5146.4 5177.8 5352.6 5356.6 5361.0 4991.5 5041.2 5044.6 5045.3 5059.6 5078.3 5086.9 5087.9 5088.1 5112.8 4714.2 4940.4 4973.6 4990.5 4999.3 4828.7 4877.8 4973.8 5090.3 5096.7 4923.2 4942.8 4947.2 4983.6 4999.6 20:25:41 INFO - PROCESS | 3419 | 20:25:41 INFO - PROCESS | 3419 | [#5] yui.html Cycles:180 Average:16930.22 Median:485.20 stddev:23474.21 (4838.0%) stddev-sans-first:23508.24 20:25:41 INFO - PROCESS | 3419 | Values: 650.7 657.8 679.0 721.5 744.2 13288.5 14271.9 14285.4 14309.1 14325.8 13259.7 13319.3 13346.7 13370.3 13409.7 607.4 622.9 748.1 760.9 773.0 776.5 783.4 785.1 785.2 785.3 825.1 825.5 826.5 826.7 826.8 646.3 662.0 778.8 799.5 818.2 595.8 595.8 596.1 596.3 596.4 11939.5 11984.6 12012.0 12043.4 12094.2 12159.5 12517.4 12538.1 12924.8 13064.3 11309.3 11485.4 11551.7 11707.2 11791.8 3938.5 3947.2 4018.7 4147.4 4181.9 61907.0 62899.4 63566.7 63583.7 63640.4 9745.2 9889.3 9974.0 10036.1 10156.8 17323.6 19057.8 19133.8 19191.8 19344.2 6862.5 6943.1 6947.7 7049.3 7331.5 3624.4 3671.8 3671.8 3682.1 3763.2 2946.8 3059.1 3060.9 3067.5 3069.0 482.1 488.3 494.5 503.6 513.0 505.6 538.6 611.3 621.7 638.1 8476.4 8606.1 8722.8 8731.9 8814.6 502.9 538.8 567.1 577.0 642.3 3978.4 4065.2 4071.3 4117.4 4132.1 74242.3 98546.5 99941.5 100460.5 102943.0 46737.3 74077.6 75893.6 76505.6 76909.6 43976.6 49634.3 68041.0 70994.3 71558.3 8253.0 8397.2 8957.2 9067.7 9079.3 31908.7 41058.8 41232.6 42280.6 43659.3 59434.4 60406.0 63015.5 63831.4 66684.0 10720.8 10985.0 11072.3 11117.1 11339.3 12378.4 12410.9 12477.0 12772.2 12826.9 11652.6 11884.9 12359.0 12472.0 12849.9 11896.2 11945.3 12009.7 12238.4 12611.0 11542.2 11634.9 11997.9 12564.7 12598.0 9426.4 9624.3 9772.6 9818.8 9820.9 9850.6 10049.3 10077.1 10256.6 10276.0 20:25:41 INFO - PROCESS | 3419 | -------- Summary: end -------- 20:25:41 INFO - PROCESS | 3419 | 20:25:42 INFO - TEST-INFO | 3419: exit 0 20:25:42 INFO - TEST-OK | dromaeo_css | took 1126185ms 20:25:42 INFO - TEST-START | kraken 20:25:42 INFO - operating with platform_type : linux_ 20:25:42 INFO - Initialising browser for kraken test... 20:25:42 INFO - TEST-INFO | started process 3727 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesG2gD/profile http://localhost:55896/getInfo.html) 20:25:47 INFO - PROCESS | 3727 | __metrics Screen width/height:1600/1200 20:25:47 INFO - PROCESS | 3727 | colorDepth:24 20:25:47 INFO - PROCESS | 3727 | Browser inner width/height: 1024/697 20:25:47 INFO - PROCESS | 3727 | __metrics 20:25:48 INFO - PROCESS | 3727 | 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" 20:25:48 INFO - PROCESS | 3727 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:48 INFO - PROCESS | 3727 | console.error: PushService: 20:25:48 INFO - PROCESS | 3727 | stateChangeProcessEnqueue: Error transitioning state 20:25:48 INFO - PROCESS | 3727 | UnknownError 20:25:49 INFO - TEST-INFO | 3727: exit 0 20:25:49 INFO - Browser initialized. 20:25:49 INFO - Running cycle 1/1 for kraken test... 20:25:49 INFO - TEST-INFO | started process 3809 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpesG2gD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:01 INFO - PROCESS | 3809 | RSS: Main: 175054848 20:26:01 INFO - PROCESS | 3809 | 20:26:04 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55896/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:05 INFO - PROCESS | 3809 | RSS: Main: 232804352 20:26:05 INFO - PROCESS | 3809 | 20:26:08 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55896/tests/kraken/driver.html?testName=audio-dft) 20:26:08 INFO - PROCESS | 3809 | RSS: Main: 218173440 20:26:08 INFO - PROCESS | 3809 | 20:26:12 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55896/tests/kraken/driver.html?testName=audio-fft) 20:26:12 INFO - PROCESS | 3809 | RSS: Main: 300191744 20:26:12 INFO - PROCESS | 3809 | 20:26:14 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55896/tests/kraken/driver.html?testName=audio-oscillator) 20:26:15 INFO - PROCESS | 3809 | RSS: Main: 211161088 20:26:15 INFO - PROCESS | 3809 | 20:26:17 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55896/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:18 INFO - PROCESS | 3809 | RSS: Main: 214114304 20:26:18 INFO - PROCESS | 3809 | 20:26:21 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55896/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:22 INFO - PROCESS | 3809 | RSS: Main: 249847808 20:26:22 INFO - PROCESS | 3809 | 20:26:25 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55896/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:26 INFO - PROCESS | 3809 | RSS: Main: 244047872 20:26:26 INFO - PROCESS | 3809 | 20:26:29 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55896/tests/kraken/driver.html?testName=json-parse-financial) 20:26:29 INFO - PROCESS | 3809 | RSS: Main: 246894592 20:26:29 INFO - PROCESS | 3809 | 20:26:31 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55896/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:31 INFO - PROCESS | 3809 | RSS: Main: 210391040 20:26:31 INFO - PROCESS | 3809 | 20:26:33 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:34 INFO - PROCESS | 3809 | RSS: Main: 218222592 20:26:34 INFO - PROCESS | 3809 | 20:26:36 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:37 INFO - PROCESS | 3809 | RSS: Main: 226881536 20:26:37 INFO - PROCESS | 3809 | 20:26:40 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:41 INFO - PROCESS | 3809 | RSS: Main: 224673792 20:26:41 INFO - PROCESS | 3809 | 20:26:44 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:45 INFO - PROCESS | 3809 | RSS: Main: 229924864 20:26:45 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | Cycle 1(1): loaded http://localhost:55896/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55896/tests/kraken/driver.html?testName=ai-astar) 20:26:47 INFO - PROCESS | 3809 | RSS: Main: 279437312 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | __start_tp_report 20:26:47 INFO - PROCESS | 3809 | _x_x_mozilla_page_load 20:26:47 INFO - PROCESS | 3809 | _x_x_mozilla_page_load_details 20:26:47 INFO - PROCESS | 3809 | |i|pagename|runs| 20:26:47 INFO - PROCESS | 3809 | |0;ai-astar;116;115;115;115;114;115;114;115;116;115 20:26:47 INFO - PROCESS | 3809 | |1;audio-beat-detection;158;130;127;178;127;130;136;126;166;135 20:26:47 INFO - PROCESS | 3809 | |2;audio-dft;162;162;163;162;161;158;161;162;160;161 20:26:47 INFO - PROCESS | 3809 | |3;audio-fft;75;76;75;109;77;76;78;77;99;77 20:26:47 INFO - PROCESS | 3809 | |4;audio-oscillator;84;84;113;84;85;85;112;83;84;110 20:26:47 INFO - PROCESS | 3809 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;117 20:26:47 INFO - PROCESS | 3809 | |6;imaging-darkroom;147;147;146;147;147;146;146;145;146;146 20:26:47 INFO - PROCESS | 3809 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;94 20:26:47 INFO - PROCESS | 3809 | |8;json-parse-financial;64;63;64;63;65;67;65;65;64;64 20:26:47 INFO - PROCESS | 3809 | |9;json-stringify-tinderbox;66;66;66;66;65;65;66;65;66;65 20:26:47 INFO - PROCESS | 3809 | |10;stanford-crypto-aes;83;83;91;89;85;84;83;83;82;82 20:26:47 INFO - PROCESS | 3809 | |11;stanford-crypto-ccm;142;146;139;140;148;137;141;137;176;144 20:26:47 INFO - PROCESS | 3809 | |12;stanford-crypto-pbkdf2;177;177;179;176;179;182;188;182;180;184 20:26:47 INFO - PROCESS | 3809 | |13;stanford-crypto-sha256-iterative;73;71;70;71;74;70;70;69;72;74 20:26:47 INFO - PROCESS | 3809 | __end_tp_report 20:26:47 INFO - PROCESS | 3809 | __start_cc_report 20:26:47 INFO - PROCESS | 3809 | _x_x_mozilla_cycle_collect,1902 20:26:47 INFO - PROCESS | 3809 | __end_cc_report 20:26:47 INFO - PROCESS | 3809 | __startTimestamp1476156407317__endTimestamp 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | ------- Summary: start ------- 20:26:47 INFO - PROCESS | 3809 | Number of tests: 14 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 20:26:47 INFO - PROCESS | 3809 | Values: 116.0 115.0 115.0 115.0 114.0 115.0 114.0 115.0 116.0 115.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:135.50 stddev:18.86 (13.9%) stddev-sans-first:19.01 20:26:47 INFO - PROCESS | 3809 | Values: 158.0 130.0 127.0 178.0 127.0 130.0 136.0 126.0 166.0 135.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 20:26:47 INFO - PROCESS | 3809 | Values: 162.0 162.0 163.0 162.0 161.0 158.0 161.0 162.0 160.0 161.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.92 (15.5%) stddev-sans-first:12.38 20:26:47 INFO - PROCESS | 3809 | Values: 75.0 76.0 75.0 109.0 77.0 76.0 78.0 77.0 99.0 77.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.00 stddev:13.33 (15.9%) stddev-sans-first:13.78 20:26:47 INFO - PROCESS | 3809 | Values: 84.0 84.0 113.0 84.0 85.0 85.0 112.0 83.0 84.0 110.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:26:47 INFO - PROCESS | 3809 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 20:26:47 INFO - PROCESS | 3809 | Values: 147.0 147.0 146.0 147.0 147.0 146.0 146.0 145.0 146.0 146.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:26:47 INFO - PROCESS | 3809 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.24 20:26:47 INFO - PROCESS | 3809 | Values: 64.0 63.0 64.0 63.0 65.0 67.0 65.0 65.0 64.0 64.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 20:26:47 INFO - PROCESS | 3809 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 66.0 65.0 66.0 65.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:83.50 stddev:3.06 (3.7%) stddev-sans-first:3.20 20:26:47 INFO - PROCESS | 3809 | Values: 83.0 83.0 91.0 89.0 85.0 84.0 83.0 83.0 82.0 82.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:143.00 stddev:11.48 (8.0%) stddev-sans-first:12.12 20:26:47 INFO - PROCESS | 3809 | Values: 142.0 146.0 139.0 140.0 148.0 137.0 141.0 137.0 176.0 144.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:181.00 stddev:3.69 (2.0%) stddev-sans-first:3.70 20:26:47 INFO - PROCESS | 3809 | Values: 177.0 177.0 179.0 176.0 179.0 182.0 188.0 182.0 180.0 184.0 20:26:47 INFO - PROCESS | 3809 | 20:26:47 INFO - PROCESS | 3809 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.78 (2.5%) stddev-sans-first:1.79 20:26:47 INFO - PROCESS | 3809 | Values: 73.0 71.0 70.0 71.0 74.0 70.0 70.0 69.0 72.0 74.0 20:26:47 INFO - PROCESS | 3809 | -------- Summary: end -------- 20:26:47 INFO - PROCESS | 3809 | 20:26:48 INFO - TEST-INFO | 3809: exit 0 20:26:48 INFO - TEST-OK | kraken | took 65932ms 20:26:48 INFO - SUITE-END | took 1192s 20:26:48 INFO - Completed test suite (00:19:52) 20:26:48 INFO - javascript benchmark 20:26:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.1998280533035, 2599.6620439342882, 2607.530644483992, 2639.036751585672, 2653.854038027908, 4544.363789069533, 4626.236670949289, 4751.40607424072, 4769.618430525563, 4789.952100478994, 4655.930161047587, 4664.0, 4675.532446755323, 4697.318888761128, 4792.281157826328, 4293.506246781613, 4317.244482215616, 4330.177266319405, 4343.565643435647, 4346.434963454746, 4298.527162012176, 4367.934480982788, 4381.145676593065, 4403.383526306319, 4454.465464144308, 4347.0, 4383.539728328527, 4396.516383197845, 4398.120375924827, 4441.689081764278, 4218.78906054696, 4246.681498887565, 4275.551067137968, 4307.5261721210645, 4330.935035974463, 4218.0720241546815, 4221.409002739619, 4243.363495475673, 4325.048489332374, 4388.253996820548, 4669.486356500816, 4672.672912896064, 4675.696079754805, 4706.3411122442885, 4755.809767609291, 4865.537773911473, 4904.681195722266, 4982.476839931791, 5016.799328026875, 5024.472430394792, 5046.798128074873, 5081.568066714333, 5085.618578606619, 5087.694738315713, 5137.126688462933, 4691.413573303337, 4715.7877895494785, 4728.0543891221205, 4730.479647238801, 4740.715557066587, 4996.90006199874, 5018.523240292239, 5022.874428139326, 5162.354705661793, 5237.5548078413, 4874.902501950012, 4889.168841296988, 4952.653314268039, 4969.105560998983, 4997.600191984632, 5045.041442125985, 5069.847904562869, 5108.106081435734, 5131.025105229995, 5131.2559678846355, 4996.750162491933, 5011.548960593491, 5016.54851063406, 5073.1122053640465, 5081.314022606901, 4795.688280261772, 4857.95142048575, 4988.625853061035, 5006.549410553068, 5008.424031236382, 4208.137331846964, 4215.620594146541, 4265.125649241898, 4266.8293268269545, 4336.76147811867, 3717.683996860297, 3722.4602432647116, 3726.4596633488536, 3764.849406023783, 3772.660460558563, 4291.957080429156, 4293.849715259951, 4296.3555466680245, 4316.525182230015, 4348.2390581648715, 4927.507249275044, 4977.576905962961, 4988.102141614471, 5016.54851063406, 5021.774020169101, 4286.61420472159, 4291.527931927485, 4291.957080429156, 4310.181065597527, 4339.088791353851, 4513.796879140446, 4522.886927826765, 4529.139463501924, 4530.6602004849765, 4586.174488592085, 4601.723896566216, 4667.62658987287, 4670.556297151765, 4706.835260765857, 4761.619070474285, 5044.218146187347, 5047.268146118866, 5050.671706339223, 5087.491250874883, 5087.821926232564, 4657.510961349009, 4675.672702910763, 4691.835785747482, 4708.246680531099, 4777.21176005969, 4829.372181616367, 4887.706737595756, 4930.7534623267975, 4947.604191664586, 5037.722925239147, 5020.924686129784, 5077.339945807022, 5083.440821509557, 5138.203578445347, 5144.845654630367, 4873.122837889214, 4877.780499877443, 4881.511848815232, 4883.389576302962, 4944.75276236194, 4754.500777418321, 4815.15734746411, 4859.975700121477, 4878.0975519529, 4937.654364194472, 4663.603593694574, 4695.906081878412, 4699.365585646031, 4710.952890471051, 4763.1426343258545, 4838.903221935471, 4871.8294859679745, 4881.8535443936735, 4881.9023619528125, 4944.3572335596145, 4639.466461356988, 4661.230896902109, 4683.0, 4691.249400095969, 4780.163471392562], "value": 4600.871267117697, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3383939272873, 559.697763207868, 561.6152935239364, 563.3690266901071, 566.1112054075103, 27618.309542261453, 38549.229015419674, 39563.802180989056, 39689.801550992204, 42749.57250427495, 40096.39855402164, 40328.337615852965, 40477.19045619086, 40495.19009619806, 40544.391834122514, 7547.283008114234, 7685.654145563435, 7686.385089192851, 7698.461107722462, 7698.884516732225, 7608.885866712004, 7700.653470593808, 7708.0, 7708.49894756839, 7711.807204819868, 7701.8074548136465, 7742.535447873118, 7752.3410510106705, 7753.961230193841, 7756.573388463632, 7684.07791065073, 7691.653875575613, 7702.191269916634, 7705.576193309365, 7706.152323244411, 7527.059117610299, 7538.0, 7591.696332146707, 7622.733204337877, 7622.8475430491635, 36889.44665830015, 37130.8143459281, 37166.0, 37244.627553724386, 37271.25457490835, 3177.5710279112254, 3192.6488086310487, 3200.9679903201136, 3376.324735052999, 3402.42158832999, 27890.151928089384, 28440.857795711097, 28653.856730716423, 28702.569461458093, 28900.566491502643, 3429.0, 3459.100633835196, 3668.8715894943816, 3680.0615842959874, 3681.742278040538, 221345.0, 223254.0, 223522.0, 223596.3482556238, 224204.0, 49532.53272270979, 49780.75109624501, 49887.50112498901, 49930.50069499331, 50122.498775012515, 53221.33893305319, 53228.46771532235, 53299.0, 53368.73315633397, 53472.19791703128, 11753.236039657395, 11818.231814932002, 11903.583374581847, 11926.46330915111, 11926.701832454259, 9102.317326200562, 9154.31342649304, 9159.038300978435, 9164.0, 9168.541572921327, 13627.727445451035, 15813.209339532978, 15849.0, 15915.681686366439, 16060.67878642444, 4898.24077268024, 5197.402298735618, 5485.588580856372, 5499.807506737245, 5587.32952045749, 707.1649070661728, 756.8826831841073, 839.9454035487673, 888.8266787976412, 989.8267803134422, 27235.0, 27614.44771104567, 27659.0, 27746.86023159864, 27907.44185116327, 929.5120061967522, 932.5523748600709, 945.4705364995486, 974.5955428497094, 997.6907158780801, 14468.131912085099, 14803.407863685332, 14839.554813355617, 14991.0, 15133.243337833064, 309790.0, 507778.0, 523465.0, 523558.0, 523703.0, 47658.5234147661, 48146.27780583294, 48157.27764083542, 48174.0, 48182.75908620434, 1058.312097136852, 1096.797092537867, 1177.6290468502393, 1200.8138738495547, 1202.9278243305255, 25433.364165896, 28928.855355723088, 29293.0, 30397.544036839907, 30500.237494062825, 44786.0, 45517.54482455133, 45523.54476455193, 45754.0, 45754.31368529408, 294747.0, 294899.0, 295038.0, 295566.0, 296052.0, 24338.0, 24500.387490312885, 24845.279396914528, 24928.62607060932, 25356.366090847878, 40642.59357406506, 40964.38553421761, 41051.794741026104, 41090.58909410868, 41124.588754112076, 34561.48157777686, 34634.82682586571, 34947.0, 35034.29931401409, 35259.82370088133, 34437.48343774795, 34911.65088349186, 34964.8322093965, 35450.468242976895, 35459.0, 29783.255418614706, 30005.549916751705, 30542.694573053985, 32565.0, 32725.0, 29060.418791624474, 31077.689223107478, 31447.21381965469, 31777.68222317747, 31800.84099579487, 24397.634035489125, 24673.383165421008, 25033.249002529952, 25083.372915676526, 25193.748062519142], "value": 16870.749250472032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.446200620042, 364.0752488678756, 367.9871204507843, 370.25209077663106, 383.75247965062533, 15359.769603455943, 16656.417025404113, 16727.247273872676, 16862.662746745056, 16889.493315200565, 15788.210589470538, 15971.84380108685, 16223.594410139753, 16250.0, 16396.0, 4831.106245344605, 5070.366204224472, 5073.188289873621, 5102.974485127569, 5133.794648214067, 3591.2637909228674, 3773.924521509568, 5055.696658200502, 5652.971735141318, 5918.082697181943, 6050.27396712393, 6087.0, 6087.117367981662, 6090.360512146227, 6094.238220222473, 5828.358880523139, 5962.463378295931, 5973.372795856416, 5986.551008674367, 5987.0, 5083.872903177413, 5237.0, 5238.816641417532, 5246.081935661244, 5248.448912864133, 16050.518484445485, 16184.0, 16223.26995285215, 16265.0, 18811.435656930313, 1864.254298280685, 1871.4479228627588, 1947.6688962876344, 2084.8749075055393, 2413.239829453734, 8839.558022098869, 12336.0, 12644.367781610883, 13032.152910060911, 13630.318484075855, 1709.7520859475305, 1744.084355713248, 1750.9124543772887, 1788.8926664400178, 1862.5157459060606, 59372.0, 67841.66079169622, 68419.65790171018, 68561.31438685599, 69364.30635693629, 9539.09378609031, 9770.477159375754, 9877.16044136242, 10011.499425028866, 10014.849777253346, 13488.325583720774, 13510.986675999142, 13529.458821647024, 13534.120282181626, 13538.59384218475, 6412.358764123644, 6577.14497115372, 6623.3376662333385, 6638.103855979478, 6760.526763126534, 6002.729877155539, 6036.909446358308, 6090.756369745249, 6187.195664563578, 6206.534509911775, 4320.481542214954, 4333.328334108218, 4342.305231162999, 4404.11917616478, 4427.623651989553, 1509.3358922074253, 1584.698907207627, 1757.384915279642, 1783.9018853962898, 1847.159542408201, 786.9488483248571, 796.3430170109683, 797.7327595255539, 863.2964134230707, 877.5831480047054, 15494.07035577869, 15935.362585496681, 16262.593435163979, 16302.0, 16640.916795415946, 816.1675091406851, 825.7068740597122, 835.9791005224918, 856.4304737349718, 872.4852337121002, 8664.91335086641, 9010.459372437545, 9431.858522122173, 9500.857487137699, 9639.71080867575, 328457.0, 328926.0, 329010.0, 358305.0, 370760.0, 76955.23044769593, 80616.59691701621, 80734.19265807384, 80776.0, 84237.83718930652, 837.0875745437625, 884.7168905950163, 896.2919293757989, 925.3106435705308, 931.9720408387759, 11927.582534611247, 15043.398264069314, 15826.28781704803, 15845.207739613204, 16117.032978021356, 33827.98516044523, 34294.65705343014, 35373.82313088418, 36602.633973659926, 38726.8381948542, 48631.75684121557, 49371.75314123406, 49388.50611493839, 49937.25094123519, 53436.0, 7248.0, 7523.774286771406, 7613.619319034137, 7616.0, 7650.770476885702, 8233.053198882206, 10836.403997779882, 11105.16711246676, 11360.0, 11631.6510504685, 6193.0, 7556.962215188889, 9620.663276785279, 10057.597696092074, 10145.9492702536, 9302.95348523253, 9515.571799269188, 9813.754656133653, 9976.351537150062, 10203.84694229602, 9560.28297877648, 9661.565229564827, 9689.22486201088, 9817.509124543602, 9818.558164882455, 7418.56636903273, 7434.219406962407, 7721.575313357819, 7864.331531819859, 7889.5660738657625, 9493.952530237304, 9602.423854568748, 9786.75533111678, 9920.0, 9987.001299870246], "value": 7979.533961473702, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.5996201139658, 1371.855955124712, 1421.4527406948328, 1624.1554391716315, 1680.1011458869507, 6526.2168539775175, 6719.428848547879, 7199.136103667561, 7788.883166752496, 7794.025746781653, 7392.149902761184, 7688.500247483909, 7690.423218258639, 7690.884636730453, 7697.114831794345, 2153.924612638562, 2181.301983365324, 2183.1922188790168, 2196.593630178414, 2198.8460807743463, 1817.0551313317067, 1882.3223639489772, 2119.8304135669187, 2152.773958734334, 2163.4483206782247, 1842.8525717942532, 1860.9162587683586, 1992.4122383896786, 2054.1577953039255, 2059.238081909688, 2128.6168489671854, 2128.648772952461, 2129.5634394948997, 2133.7866213378693, 2134.5304033112766, 2060.9072591733407, 2105.631514484959, 2105.7052012718077, 2109.177420805887, 2120.9257675981266, 7674.693012279502, 7708.152103268636, 7710.807229819244, 7762.0, 7763.0684317882215, 4199.559046300125, 4384.4519435070615, 4435.911281774379, 4438.245498265303, 4439.356293337481, 2871.1530098620747, 2927.985360073186, 2982.284251779579, 3000.6549246836676, 3006.759459243255, 898.1333013641802, 949.767307009787, 964.4936408385654, 964.9783703141976, 966.8308046091976, 10289.0, 10327.896721032768, 10342.431166285927, 10367.481625918674, 10391.272610917238, 3871.903202419962, 4080.9795951020646, 4136.255474014646, 4228.809703563285, 4241.236577416094, 8845.0, 8846.15961483658, 8851.867221991675, 8854.557272136368, 8917.910820891837, 4292.055747735493, 4294.0, 4294.763787991628, 4315.6763242756915, 4316.589923957219, 3834.367329390675, 3834.7699138051807, 3837.4627552142724, 3841.193349396658, 3841.615838416136, 3225.6129264488413, 3293.950590741141, 3301.224212310105, 3305.801651900894, 3314.6022477302877, 1020.1125021231576, 1029.2126523209752, 1037.7353774787532, 1039.3867618105355, 1047.450088703437, 837.8952630921135, 845.6152450634946, 859.8263370499349, 875.3609864798606, 884.3720958119678, 5066.898662026812, 5140.768665410065, 5236.947630523722, 5252.0, 5349.170878513836, 704.4786857725246, 705.7071315404153, 712.113418793595, 748.2293237964905, 760.0803028335665, 3439.6216416194197, 3506.2461570762407, 3519.595246546629, 3539.150603855056, 3597.7661452005536, 8708.129187081367, 9017.774555636162, 9057.0, 9067.54662266884, 9175.724728258163, 8817.206451419275, 8994.280457563511, 8999.145081217273, 9003.77490562728, 9040.141186587263, 7001.614911179934, 7127.536710113826, 7165.032720582654, 7165.89251161233, 7167.498275120692, 5073.2897394365555, 5111.233315002779, 5146.279520867157, 5173.22401639757, 5302.019126461617, 8340.958295208486, 8474.788130296793, 8582.141785821368, 8607.956960215159, 8645.697400590949, 8564.52895090776, 8645.135486451305, 8740.868886966828, 8755.43089699193, 8777.0, 6204.410580994799, 6212.285587157354, 6241.845258627169, 6277.497800175884, 6308.116863639002, 7203.459740519586, 7259.673314700745, 7267.236940121211, 7267.927320726725, 7275.490715650066, 6091.573589848668, 6150.4792838469675, 6233.625982441068, 6270.717817698123, 6359.96820015897, 6460.418562329413, 6491.707873145814, 6510.544261901621, 6525.967370163119, 6535.705893234721, 6041.6375017499095, 6127.754889804536, 6130.111133885473, 6131.938680613315, 6135.0, 4508.278675411918, 4512.9548704513845, 4540.160070386989, 4597.218472859555, 4607.124646317189, 4348.499922508952, 4412.580804823537, 4414.757188354672, 4635.3278774578175, 4674.462436819809], "value": 3973.472713129575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.6838335555988, 303.62047440699126, 307.7015295163692, 308.6558487286676, 312.9561861339413, 4830.734309612974, 4838.080764654713, 4852.441969173546, 4883.169861123609, 4908.312836202935, 4822.710637361761, 4865.41873890986, 4871.878203044926, 4888.0, 4893.510648935105, 3614.4216925291958, 3721.3301605710963, 3786.848526058954, 3828.119532507525, 3848.826802793881, 3840.327942610032, 3849.7690138591774, 3853.0, 3863.343231650612, 3886.397608370707, 3803.413678698484, 3814.9427758583643, 3819.9045023874487, 3822.069854723361, 3847.230553889219, 3582.3730847101783, 3699.90750231245, 3749.212665340282, 3811.313963486571, 3828.846846126152, 3370.4607262837826, 3376.7467439941856, 3386.646280834796, 3389.7288216942584, 3391.524686761267, 4711.670183087185, 4728.172569800271, 4735.479097299294, 4740.360051393087, 4791.377120974286, 4256.899634033412, 4312.159128969852, 4388.648908087345, 4428.977855110736, 4436.334549817521, 5040.395152581677, 5045.747712614391, 5054.028928717803, 5055.216441451544, 5058.494150584949, 3702.833372498244, 3719.2189640175598, 3723.590405055442, 3730.0301921500336, 3742.6257374262627, 5251.291075704769, 5333.6266461348105, 5364.302640656729, 5366.436524164946, 5393.460653934614, 3781.149241420658, 3808.6000969897764, 3813.8474461021246, 3818.1981783825154, 3821.522309711286, 3873.2253549290253, 3882.6311500407414, 3888.3389823730035, 3904.8090332448874, 3907.296686596383, 4395.450568678915, 4395.494518130392, 4399.626031787334, 4407.118576284756, 4409.889752756143, 4972.7513624318635, 5054.9241761373605, 5060.544550990428, 5069.771860266297, 5085.4914508548845, 1314.0341848741168, 1321.1610627251764, 1324.913880597758, 1328.5881376773232, 1330.4678128748385, 811.5739236900674, 836.2056046755606, 870.950504641905, 872.5855218771032, 881.290561098322, 4255.297875850512, 4301.892452688708, 4450.666200035011, 4451.821927122944, 4479.776011199427, 5128.461511541309, 5232.92150617741, 5233.0, 5242.7378631068295, 5256.684598924076, 4412.205802955499, 4430.269005614037, 4446.977765111218, 4479.753613551221, 4491.932621010687, 2625.912399642289, 2788.386554957906, 2788.4980703473166, 2789.1353680359152, 2794.413173233603, 4916.975415122902, 4921.655484116078, 4935.506449355107, 4936.975315123402, 4960.826371076995, 5248.6588371755715, 5355.0, 5404.945950540523, 5410.269613602113, 5420.891582168335, 4886.071646387175, 4887.95112048882, 4912.238603016538, 4920.360353154067, 4926.999999999928, 5201.930860792151, 5213.739313034409, 5220.347456567929, 5228.607854410859, 5281.471852814688, 4922.630802689741, 5140.712382989534, 5172.379314482287, 5180.8137995131965, 5194.8961020780125, 4954.727489987941, 4957.504249575014, 4958.727270000185, 4963.751812409438, 4975.0, 3723.255348930171, 3725.1245957200576, 3758.2483503298904, 3774.7735135891935, 3780.1494663700446, 5146.382434107931, 5177.8187763428095, 5352.625316227983, 5356.5714742821265, 5360.973195133999, 4991.5258050485145, 5041.218611115283, 5044.621653375938, 5045.268436076822, 5059.645824792229, 5078.339815823919, 5086.949130508796, 5087.949120508748, 5088.109580823415, 5112.821051263188, 4714.245720684674, 4940.407151141742, 4973.607389930825, 4990.47600002009, 4999.250112483157, 4828.734419606955, 4877.829275975324, 4973.751312434436, 5090.312807771052, 5096.694198348111, 4923.187674033744, 4942.802287908444, 4947.208446648519, 4983.576396006235, 4999.575036121971], "value": 3849.100536141111, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.6779144323559, 657.7599176300652, 678.9864202715949, 721.5021635071801, 744.2074190986599, 13288.46846126155, 14271.928640356784, 14285.428582856699, 14309.069910455826, 14325.78511322331, 13259.734805303888, 13319.33403329832, 13346.733065338713, 13370.264635445046, 13409.731805363886, 607.3926073926074, 622.925248970122, 748.1022772672801, 760.9239076092401, 772.9768106956773, 776.4758787818229, 783.3811289081647, 785.1089013969129, 785.2265518464308, 785.2657764989724, 825.0800357601262, 825.471698113208, 826.450410477032, 826.7354446577098, 826.7809030606863, 646.3342756960315, 661.9801405957829, 778.7975126467103, 799.5282783157965, 818.1818181818181, 595.7944509144338, 595.803384882992, 596.1326270276737, 596.2665920917252, 596.3976383852297, 11939.522419103225, 11984.64046078619, 12012.0, 12043.397830108546, 12094.213876098114, 12159.51361945521, 12517.43671534783, 12538.122331436804, 12924.806127908088, 13064.346782660828, 11309.313053235257, 11485.368304743235, 11551.711207219887, 11707.239029463057, 11791.764164716744, 3938.5273767147837, 3947.1513624570566, 4018.6985976051915, 4147.39862719907, 4181.853635122756, 61907.0, 62899.37100628981, 63566.68216658934, 63583.68208158976, 63640.36359636391, 9745.171660408803, 9889.258305627107, 9973.950130249303, 10036.146927511098, 10156.796864062677, 17323.56691082733, 19057.809421905604, 19133.8086619132, 19191.80808191928, 19344.226230950604, 6862.519623626298, 6943.062686537354, 6947.7220911162985, 7049.330313620198, 7331.486795924234, 3624.3838547447, 3671.761335513183, 3671.7980511071614, 3682.0978860179425, 3763.209725957525, 2946.8379239142055, 3059.1128572713665, 3060.8928687496277, 3067.5245336972803, 3069.048594935577, 482.08404032338836, 488.3187952805887, 494.5054945054945, 503.6373810856178, 512.9923051154236, 505.56268827464714, 538.6471860931097, 611.3336463255073, 621.6736213487865, 638.1257676982564, 8476.449030812977, 8606.139386061344, 8722.825543489094, 8731.869021964676, 8814.647414103492, 502.85668584453254, 538.7898719499399, 567.0954827050847, 576.9845072672043, 642.3063091860872, 3978.4430179774854, 4065.2276067547073, 4071.267171909085, 4117.402976568381, 4132.070284186094, 74242.25757742353, 98546.52180217303, 99941.50029249807, 100460.49769751105, 102943.0, 46737.29894051592, 74077.62961185268, 75893.62053189699, 76505.61747191228, 76909.61545192238, 43976.56023439725, 49634.255486167734, 68041.0, 70994.2900570998, 71558.28441715516, 8253.0, 8397.244248017707, 8957.238634716123, 9067.68263110788, 9079.319051071065, 31908.680913190572, 41058.79470602628, 41232.58767412407, 42280.57719422766, 43659.34510982401, 59434.40565594289, 60406.0, 63015.547667848354, 63831.361686382545, 66684.0, 10720.839187412039, 10985.0, 11072.335659860435, 11117.110631149328, 11339.319640821577, 12378.381080946097, 12410.937945310216, 12477.0, 12772.169808962388, 12826.871731282941, 11652.592159274385, 11884.940575297069, 12359.0, 12472.0, 12849.935750321189, 11896.22674526153, 11945.283283003047, 12009.699757506132, 12238.449269782703, 12611.0, 11542.19204655666, 11634.883651163718, 11997.880021200026, 12564.748705025666, 12598.0, 9426.401100544434, 9624.326297159132, 9772.609095636379, 9818.803623927624, 9820.901790982, 9850.605975761177, 10049.296549241482, 10077.143442807443, 10256.589736410759, 10276.0], "value": 6531.497118710631, "unit": "score"}], "name": "dromaeo_css", "value": 6289.129075991906, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 115.0, 116.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 130.0, 127.0, 178.0, 127.0, 130.0, 136.0, 126.0, 166.0, 135.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 161.0, 158.0, 161.0, 162.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 109.0, 77.0, 76.0, 78.0, 77.0, 99.0, 77.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 84.0, 85.0, 85.0, 112.0, 83.0, 84.0, 110.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 63.0, 65.0, 67.0, 65.0, 65.0, 64.0, 64.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 91.0, 89.0, 85.0, 84.0, 83.0, 83.0, 82.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 146.0, 139.0, 140.0, 148.0, 137.0, 141.0, 137.0, 176.0, 144.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 177.0, 179.0, 176.0, 179.0, 182.0, 188.0, 182.0, 180.0, 184.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 70.0, 71.0, 74.0, 70.0, 70.0, 69.0, 72.0, 74.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1561.4, "alertThreshold": 2.0}]} 20:26:49 INFO - Return code: 0 20:26:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:49 INFO - # TBPL SUCCESS # 20:26:49 INFO - Running post-action listener: _resource_record_post_action 20:26:49 INFO - [mozharness: 2016-10-11 03:26:49.114202Z] Finished run-tests step (success) 20:26:49 INFO - Running post-run listener: _resource_record_post_run 20:26:49 INFO - Total resource usage - Wall time: 1210s; CPU: 13.0%; Read bytes: 7852032; Write bytes: 429379584; Read time: 2932; Write time: 672720 20:26:49 INFO - TinderboxPrint: CPU usage
13.0% 20:26:49 INFO - TinderboxPrint: I/O read bytes / time
7,852,032 / 2,932 20:26:49 INFO - TinderboxPrint: I/O write bytes / time
429,379,584 / 672,720 20:26:49 INFO - TinderboxPrint: CPU idle
8,394.5 (87.0%) 20:26:49 INFO - TinderboxPrint: CPU user
1,202.5 (12.5%) 20:26:49 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 20860928; Read time: 0; Write time: 33964 20:26:49 INFO - run-tests - Wall time: 1194s; CPU: 13.0%; Read bytes: 6107136; Write bytes: 376041472; Read time: 2444; Write time: 624544 20:26:49 INFO - Running post-run listener: _upload_blobber_files 20:26:49 INFO - Blob upload gear active. 20:26:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:49 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 20:26:49 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:49 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:53 INFO - (blobuploader) - INFO - Done attempting. 20:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:54 INFO - (blobuploader) - INFO - Done attempting. 20:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:55 INFO - (blobuploader) - INFO - Done attempting. 20:26:55 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:55 INFO - Return code: 0 20:26:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8eeb490e457f5b7efce624ea68399deca266fa2fa0b1ae69411e95b178e64900e2b81e5ad7ce9092316f3410ccd4b69d172b71d67b1f8fda14875c4fc515ce1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc0a203038ef2ea1774f130925977116b7ff2addb6e848a00b7dfd2d16a03ea35c61a6268ca16b59a38f6556119123285e25fd0de84f829cbd9b30d3a06df7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2924570c39186e9b24daf26cdfb8b32f6d880d66e2b8bcd1ef2912a824ec827cc0c226b4c17af9194abaa9741352d48a7a77656f34b20a5fe04e860d62952769"} 20:26:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:55 INFO - Contents: 20:26:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8eeb490e457f5b7efce624ea68399deca266fa2fa0b1ae69411e95b178e64900e2b81e5ad7ce9092316f3410ccd4b69d172b71d67b1f8fda14875c4fc515ce1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc0a203038ef2ea1774f130925977116b7ff2addb6e848a00b7dfd2d16a03ea35c61a6268ca16b59a38f6556119123285e25fd0de84f829cbd9b30d3a06df7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2924570c39186e9b24daf26cdfb8b32f6d880d66e2b8bcd1ef2912a824ec827cc0c226b4c17af9194abaa9741352d48a7a77656f34b20a5fe04e860d62952769"} 20:26:55 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:55 INFO - Copying logs to upload dir... 20:26:55 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.455723 ========= master_lag: 0.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-10-10 20:26:55.883216) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 20:26:55.888633) ========= 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=af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190 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-Non-PGO/sha512/f8eeb490e457f5b7efce624ea68399deca266fa2fa0b1ae69411e95b178e64900e2b81e5ad7ce9092316f3410ccd4b69d172b71d67b1f8fda14875c4fc515ce1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc0a203038ef2ea1774f130925977116b7ff2addb6e848a00b7dfd2d16a03ea35c61a6268ca16b59a38f6556119123285e25fd0de84f829cbd9b30d3a06df7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2924570c39186e9b24daf26cdfb8b32f6d880d66e2b8bcd1ef2912a824ec827cc0c226b4c17af9194abaa9741352d48a7a77656f34b20a5fe04e860d62952769"} build_url:https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/Rm6eXA2RRoiAFpO07wV0Tw/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-Non-PGO/sha512/f8eeb490e457f5b7efce624ea68399deca266fa2fa0b1ae69411e95b178e64900e2b81e5ad7ce9092316f3410ccd4b69d172b71d67b1f8fda14875c4fc515ce1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bc0a203038ef2ea1774f130925977116b7ff2addb6e848a00b7dfd2d16a03ea35c61a6268ca16b59a38f6556119123285e25fd0de84f829cbd9b30d3a06df7a4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2924570c39186e9b24daf26cdfb8b32f6d880d66e2b8bcd1ef2912a824ec827cc0c226b4c17af9194abaa9741352d48a7a77656f34b20a5fe04e860d62952769"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 20:26:55.922128) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:26:55.922521) ========= 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=af724c981e2a0f424dbabf99000001e7-1476149931.818669-892284190 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 20:26:55.972136) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 20:26:55.973684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 20:26:55.974001) ========= ========= Total master_lag: 0.89 =========