builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1477389375.41 results: success (0) buildid: 20161025012704 builduid: 18aeafa847a049edbfd4eabda9079d00 revision: 9fb2ac0875ec35268701dd3826b017a301cc7400 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.410785) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.411236) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.411525) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.427115) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.427504) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 02:56:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2016-10-25 02:56:15 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131701 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.573712) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.574040) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017906 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:15.624147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 02:56:15.624496) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9fb2ac0875ec35268701dd3826b017a301cc7400 --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 9fb2ac0875ec35268701dd3826b017a301cc7400 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 02:56:16,086 truncating revision to first 12 chars 2016-10-25 02:56:16,086 Setting DEBUG logging. 2016-10-25 02:56:16,086 attempt 1/10 2016-10-25 02:56:16,086 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9fb2ac0875ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 02:56:16,776 unpacking tar archive at: mozilla-central-9fb2ac0875ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.028968 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-25 02:56:16.666837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:16.667146) ========= script_repo_revision: 9fb2ac0875ec35268701dd3826b017a301cc7400 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:16.667560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:16.668126) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 02:56:16.677874) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-25 02:56:16.678272) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:56:17 INFO - MultiFileLogger online at 20161025 02:56:17 in /builds/slave/test 02:56:17 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 02:56:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:56:17 INFO - {'append_to_log': False, 02:56:17 INFO - 'base_work_dir': '/builds/slave/test', 02:56:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:56:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:56:17 INFO - 'branch': 'Firefox-Non-PGO', 02:56:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:56:17 INFO - 'config_files': ('talos/linux_config.py',), 02:56:17 INFO - 'default_actions': ('clobber', 02:56:17 INFO - 'read-buildbot-config', 02:56:17 INFO - 'download-and-extract', 02:56:17 INFO - 'populate-webroot', 02:56:17 INFO - 'create-virtualenv', 02:56:17 INFO - 'install', 02:56:17 INFO - 'run-tests'), 02:56:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:56:17 INFO - 'download_minidump_stackwalk': True, 02:56:17 INFO - 'download_symbols': 'ondemand', 02:56:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:56:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:56:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:56:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:56:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:56:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:56:17 INFO - 'installer_path': 'installer.exe', 02:56:17 INFO - 'log_level': 'info', 02:56:17 INFO - 'log_name': 'talos', 02:56:17 INFO - 'log_to_console': True, 02:56:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:56:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:56:17 INFO - 'opt_config_files': (), 02:56:17 INFO - 'pip_index': False, 02:56:17 INFO - 'sps_profile': False, 02:56:17 INFO - 'sps_profile_interval': 0, 02:56:17 INFO - 'suite': 'dromaeojs', 02:56:17 INFO - 'system_bits': '32', 02:56:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:56:17 INFO - 'title': 'talos-linux64-ix-041', 02:56:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:56:17 INFO - 'use_talos_json': True, 02:56:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:56:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:56:17 INFO - 'work_dir': 'build'} 02:56:17 INFO - [mozharness: 2016-10-25 09:56:17.241222Z] Running clobber step. 02:56:17 INFO - Running pre-action listener: _resource_record_pre_action 02:56:17 INFO - Running main action method: clobber 02:56:17 INFO - rmtree: /builds/slave/test/build 02:56:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:56:18 INFO - Running post-action listener: _resource_record_post_action 02:56:18 INFO - [mozharness: 2016-10-25 09:56:18.223641Z] Finished clobber step (success) 02:56:18 INFO - [mozharness: 2016-10-25 09:56:18.223740Z] Running read-buildbot-config step. 02:56:18 INFO - Running pre-action listener: _resource_record_pre_action 02:56:18 INFO - Running main action method: read_buildbot_config 02:56:18 INFO - Using buildbot properties: 02:56:18 INFO - { 02:56:18 INFO - "project": "", 02:56:18 INFO - "product": "firefox", 02:56:18 INFO - "script_repo_revision": "production", 02:56:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 02:56:18 INFO - "repository": "", 02:56:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 02:56:18 INFO - "buildid": "20161025012704", 02:56:18 INFO - "pgo_build": "False", 02:56:18 INFO - "basedir": "/builds/slave/test", 02:56:18 INFO - "buildnumber": 693, 02:56:18 INFO - "slavename": "talos-linux64-ix-041", 02:56:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:56:18 INFO - "platform": "ubuntu64_hw", 02:56:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 02:56:18 INFO - "branch": "mozilla-central", 02:56:18 INFO - "repo_path": "mozilla-central", 02:56:18 INFO - "revision": "9fb2ac0875ec35268701dd3826b017a301cc7400", 02:56:18 INFO - "stage_platform": "linux64", 02:56:18 INFO - "builduid": "18aeafa847a049edbfd4eabda9079d00", 02:56:18 INFO - "slavebuilddir": "test" 02:56:18 INFO - } 02:56:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 02:56:18 INFO - Running post-action listener: _resource_record_post_action 02:56:18 INFO - [mozharness: 2016-10-25 09:56:18.226187Z] Finished read-buildbot-config step (success) 02:56:18 INFO - [mozharness: 2016-10-25 09:56:18.226275Z] Running download-and-extract step. 02:56:18 INFO - Running pre-action listener: _resource_record_pre_action 02:56:18 INFO - Running main action method: download_and_extract 02:56:18 INFO - mkdir: /builds/slave/test/build/tests 02:56: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')]} 02:56:18 INFO - trying https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:56:18 INFO - Downloading https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/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 02:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/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 02:56:19 INFO - Downloaded 1361 bytes. 02:56:19 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 02:56:19 INFO - Using the following test package requirements: 02:56:19 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:56:19 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:56:19 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:56:19 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'jsshell-linux-x86_64.zip'], 02:56:19 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:56:19 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 02:56:19 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:56:19 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:56:19 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:56:19 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 02:56:19 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:56:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:56:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:56:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:56:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:56:20 INFO - Http code: 200 02:56:20 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 02:56:20 INFO - x-amz-cf-id: ZfAXZR_qtjMzyDMFLF6C9OoAXArNhZegqL0_e58SAwyWdcLBXumfTA== 02:56:20 INFO - x-amz-version-id: qNC94VnnW8NkLINBJY_3tVzai274BA.0 02:56:20 INFO - Expected file size: 20453763 02:56:20 INFO - Obtained file size: 20453763 02:56:24 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 02:56:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 02:56:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:56:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 02:56:25 INFO - Http code: 200 02:56:25 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 02:56:25 INFO - x-amz-cf-id: QpehoNnDEcbAHM2Nymabg_A8QNZfcU6w92XeCK-SFN3i7lp-j__dKg== 02:56:25 INFO - x-amz-version-id: qNC94VnnW8NkLINBJY_3tVzai274BA.0 02:56:25 INFO - Expected file size: 20453763 02:56:25 INFO - Obtained file size: 20453763 02:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 02:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 02:56:31 INFO - Http code: 200 02:56:31 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 02:56:31 INFO - x-amz-cf-id: T1WuizX8EqTJoJ2PhEIhy8sDxQyrMwPnhvqMb-bPLSwqVXhXjJ-VuA== 02:56:31 INFO - x-amz-version-id: kqV7x13qx4NRBHLWp5ru8qBtPbxz34LX 02:56:40 INFO - Expected file size: 14409028 02:56:40 INFO - Obtained file size: 14409028 02:56:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:41 INFO - trying https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:56:41 INFO - Downloading https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/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 02:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/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 02:56:42 INFO - Downloaded 55580899 bytes. 02:56:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:56:42 INFO - mkdir: /builds/slave/test/properties 02:56:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:56:42 INFO - Writing to file /builds/slave/test/properties/build_url 02:56:42 INFO - Contents: 02:56:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 02:56:43 INFO - Running post-action listener: _resource_record_post_action 02:56:43 INFO - Running post-action listener: set_extra_try_arguments 02:56:43 INFO - [mozharness: 2016-10-25 09:56:43.268847Z] Finished download-and-extract step (success) 02:56:43 INFO - [mozharness: 2016-10-25 09:56:43.269074Z] Running populate-webroot step. 02:56:43 INFO - Running pre-action listener: _resource_record_pre_action 02:56:43 INFO - Running main action method: populate_webroot 02:56:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:56:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:56:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:56:43 INFO - '--tppagecycles', 02:56:43 INFO - '7'], 02:56:43 INFO - 'tests': ['tsvgm']}}, 02:56:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:56:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:56:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:56:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:56:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:56:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['damp', 'tps']}, 02:56:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'tests': ['damp', 'tps']}, 02:56:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['dromaeo_dom']}, 02:56:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:56:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['basic_compositor_video']}, 02:56:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:56:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['a11yr', 02:56:43 INFO - 'ts_paint', 02:56:43 INFO - 'tpaint', 02:56:43 INFO - 'sessionrestore', 02:56:43 INFO - 'sessionrestore_no_auto_restore', 02:56:43 INFO - 'tabpaint']}, 02:56:43 INFO - 'other-e10s': {'tests': ['a11yr', 02:56:43 INFO - 'ts_paint', 02:56:43 INFO - 'tpaint', 02:56:43 INFO - 'sessionrestore', 02:56:43 INFO - 'sessionrestore_no_auto_restore', 02:56:43 INFO - 'tabpaint']}, 02:56:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:56:43 INFO - 'ts_paint', 02:56:43 INFO - 'tpaint', 02:56:43 INFO - 'sessionrestore', 02:56:43 INFO - 'sessionrestore_no_auto_restore', 02:56:43 INFO - 'tabpaint']}, 02:56:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:56:43 INFO - 'ts_paint', 02:56:43 INFO - 'tpaint', 02:56:43 INFO - 'sessionrestore', 02:56:43 INFO - 'sessionrestore_no_auto_restore', 02:56:43 INFO - 'tabpaint']}, 02:56:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['a11yr', 02:56:43 INFO - 'ts_paint', 02:56:43 INFO - 'tpaint', 02:56:43 INFO - 'sessionrestore', 02:56:43 INFO - 'sessionrestore_no_auto_restore', 02:56:43 INFO - 'tabpaint']}, 02:56:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['a11yr', 02:56:43 INFO - 'ts_paint', 02:56:43 INFO - 'tpaint', 02:56:43 INFO - 'sessionrestore', 02:56:43 INFO - 'sessionrestore_no_auto_restore', 02:56:43 INFO - 'tabpaint']}, 02:56:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['tsvgx', 02:56:43 INFO - 'tsvgr_opacity', 02:56:43 INFO - 'tart', 02:56:43 INFO - 'tscrollx', 02:56:43 INFO - 'cart']}, 02:56:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:56:43 INFO - 'tsvgr_opacity', 02:56:43 INFO - 'tart', 02:56:43 INFO - 'tscrollx', 02:56:43 INFO - 'cart']}, 02:56:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'talos_options': ['--disable-e10s'], 02:56:43 INFO - 'tests': ['tp5o']}, 02:56:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'tests': ['tp5o']}, 02:56:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'talos_options': ['--disable-e10s', 02:56:43 INFO - '--xperf_path', 02:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:43 INFO - 'tests': ['tp5n']}, 02:56:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:56:43 INFO - 'talos_options': ['--xperf_path', 02:56:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:56:43 INFO - 'tests': ['tp5n']}}, 02:56:43 INFO - 'talos.zip': {'path': '', 02:56:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:56:43 INFO - Running post-action listener: _resource_record_post_action 02:56:43 INFO - [mozharness: 2016-10-25 09:56:43.287835Z] Finished populate-webroot step (success) 02:56:43 INFO - [mozharness: 2016-10-25 09:56:43.287923Z] Running create-virtualenv step. 02:56:43 INFO - Running pre-action listener: _resource_record_pre_action 02:56:43 INFO - Running main action method: create_virtualenv 02:56:43 INFO - Creating virtualenv /builds/slave/test/build/venv 02:56:43 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 02:56:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:56:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:56:43 INFO - Using real prefix '/usr' 02:56:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:56:43 INFO - Installing distribute.............................................................................................................................................................................................done. 02:56:45 INFO - Installing pip.................done. 02:56:45 INFO - Return code: 0 02:56:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:56:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:56:46 INFO - Reading from file tmpfile_stdout 02:56:46 INFO - Output received: 02:56:46 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) 02:56:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:56:46 INFO - Using env: {'DISPLAY': ':0', 02:56:46 INFO - 'HOME': '/home/cltbld', 02:56:46 INFO - 'LANG': 'en_US.UTF-8', 02:56:46 INFO - 'LANGUAGE': 'en_US:en', 02:56:46 INFO - 'LOGNAME': 'cltbld', 02:56:46 INFO - 'MAIL': '/var/mail/cltbld', 02:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:46 INFO - 'MOZ_NO_REMOTE': '1', 02:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:46 INFO - 'NO_EM_RESTART': '1', 02:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:46 INFO - 'PWD': '/builds/slave/test', 02:56:46 INFO - 'SHELL': '/bin/bash', 02:56:46 INFO - 'SHLVL': '1', 02:56:46 INFO - 'TERM': 'linux', 02:56:46 INFO - 'TMOUT': '86400', 02:56:46 INFO - 'USER': 'cltbld', 02:56:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:46 INFO - '_': '/tools/buildbot/bin/python'} 02:56:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:46 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 02:56:46 INFO - Cleaning up... 02:56:46 INFO - Return code: 0 02:56:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:56:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:56:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:56:46 INFO - Using env: {'DISPLAY': ':0', 02:56:46 INFO - 'HOME': '/home/cltbld', 02:56:46 INFO - 'LANG': 'en_US.UTF-8', 02:56:46 INFO - 'LANGUAGE': 'en_US:en', 02:56:46 INFO - 'LOGNAME': 'cltbld', 02:56:46 INFO - 'MAIL': '/var/mail/cltbld', 02:56:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:46 INFO - 'MOZ_NO_REMOTE': '1', 02:56:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:46 INFO - 'NO_EM_RESTART': '1', 02:56:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:46 INFO - 'PWD': '/builds/slave/test', 02:56:46 INFO - 'SHELL': '/bin/bash', 02:56:46 INFO - 'SHLVL': '1', 02:56:46 INFO - 'TERM': 'linux', 02:56:46 INFO - 'TMOUT': '86400', 02:56:46 INFO - 'USER': 'cltbld', 02:56:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:56:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:46 INFO - '_': '/tools/buildbot/bin/python'} 02:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:47 INFO - Downloading/unpacking psutil>=3.1.1 02:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:49 INFO - Installing collected packages: psutil 02:56:49 INFO - Running setup.py install for psutil 02:56:49 INFO - building 'psutil._psutil_linux' extension 02:56:49 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 02:56:49 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 02:56:49 INFO - building 'psutil._psutil_posix' extension 02:56:49 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 02:56:49 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 02:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:56:49 INFO - Successfully installed psutil 02:56:49 INFO - Cleaning up... 02:56:50 INFO - Return code: 0 02:56:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:50 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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:56:50 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 02:56:50 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 02:56:50 INFO - Using env: {'DISPLAY': ':0', 02:56:50 INFO - 'HOME': '/home/cltbld', 02:56:50 INFO - 'LANG': 'en_US.UTF-8', 02:56:50 INFO - 'LANGUAGE': 'en_US:en', 02:56:50 INFO - 'LOGNAME': 'cltbld', 02:56:50 INFO - 'MAIL': '/var/mail/cltbld', 02:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:50 INFO - 'MOZ_NO_REMOTE': '1', 02:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:50 INFO - 'NO_EM_RESTART': '1', 02:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:50 INFO - 'PWD': '/builds/slave/test', 02:56:50 INFO - 'SHELL': '/bin/bash', 02:56:50 INFO - 'SHLVL': '1', 02:56:50 INFO - 'TERM': 'linux', 02:56:50 INFO - 'TMOUT': '86400', 02:56:50 INFO - 'USER': 'cltbld', 02:56:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:50 INFO - '_': '/tools/buildbot/bin/python'} 02:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:56:50 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 02:56:50 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 02:56:50 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 02:56:50 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 02:56:50 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 02:56:50 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 02:56:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:56:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:56:54 INFO - Installing collected packages: mozsystemmonitor 02:56:54 INFO - Running setup.py install for mozsystemmonitor 02:56:54 INFO - Successfully installed mozsystemmonitor 02:56:54 INFO - Cleaning up... 02:56:54 INFO - Return code: 0 02:56:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:56:54 INFO - Using env: {'DISPLAY': ':0', 02:56:54 INFO - 'HOME': '/home/cltbld', 02:56:54 INFO - 'LANG': 'en_US.UTF-8', 02:56:54 INFO - 'LANGUAGE': 'en_US:en', 02:56:54 INFO - 'LOGNAME': 'cltbld', 02:56:54 INFO - 'MAIL': '/var/mail/cltbld', 02:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:54 INFO - 'MOZ_NO_REMOTE': '1', 02:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:56:54 INFO - 'NO_EM_RESTART': '1', 02:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:54 INFO - 'PWD': '/builds/slave/test', 02:56:54 INFO - 'SHELL': '/bin/bash', 02:56:54 INFO - 'SHLVL': '1', 02:56:54 INFO - 'TERM': 'linux', 02:56:54 INFO - 'TMOUT': '86400', 02:56:54 INFO - 'USER': 'cltbld', 02:56:54 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:54 INFO - '_': '/tools/buildbot/bin/python'} 02:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:54 INFO - Downloading/unpacking jsonschema==2.5.1 02:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:00 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:00 INFO - warning: no files found matching '*.txt' 02:57:00 INFO - no previously-included directories found matching 'build' 02:57:00 INFO - no previously-included directories found matching 'dist' 02:57:00 INFO - no previously-included directories found matching '.git*' 02:57:00 INFO - Installing collected packages: jsonschema, functools32 02:57:00 INFO - Running setup.py install for functools32 02:57:00 INFO - warning: no files found matching '*.txt' 02:57:00 INFO - no previously-included directories found matching 'build' 02:57:00 INFO - no previously-included directories found matching 'dist' 02:57:00 INFO - no previously-included directories found matching '.git*' 02:57:00 INFO - Successfully installed jsonschema functools32 02:57:00 INFO - Cleaning up... 02:57:00 INFO - Return code: 0 02:57:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:57:00 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')]} 02:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:00 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')]} 02:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:00 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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:57:00 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 02:57:00 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 02:57:00 INFO - Using env: {'DISPLAY': ':0', 02:57:00 INFO - 'HOME': '/home/cltbld', 02:57:00 INFO - 'LANG': 'en_US.UTF-8', 02:57:00 INFO - 'LANGUAGE': 'en_US:en', 02:57:00 INFO - 'LOGNAME': 'cltbld', 02:57:00 INFO - 'MAIL': '/var/mail/cltbld', 02:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:00 INFO - 'MOZ_NO_REMOTE': '1', 02:57:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:00 INFO - 'NO_EM_RESTART': '1', 02:57:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:00 INFO - 'PWD': '/builds/slave/test', 02:57:00 INFO - 'SHELL': '/bin/bash', 02:57:00 INFO - 'SHLVL': '1', 02:57:00 INFO - 'TERM': 'linux', 02:57:00 INFO - 'TMOUT': '86400', 02:57:00 INFO - 'USER': 'cltbld', 02:57:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:00 INFO - '_': '/tools/buildbot/bin/python'} 02:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:57:01 INFO - Cleaning up... 02:57:01 INFO - Return code: 0 02:57:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:57:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:57:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:57:01 INFO - Using env: {'DISPLAY': ':0', 02:57:01 INFO - 'HOME': '/home/cltbld', 02:57:01 INFO - 'LANG': 'en_US.UTF-8', 02:57:01 INFO - 'LANGUAGE': 'en_US:en', 02:57:01 INFO - 'LOGNAME': 'cltbld', 02:57:01 INFO - 'MAIL': '/var/mail/cltbld', 02:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:01 INFO - 'MOZ_NO_REMOTE': '1', 02:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:01 INFO - 'NO_EM_RESTART': '1', 02:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:01 INFO - 'PWD': '/builds/slave/test', 02:57:01 INFO - 'SHELL': '/bin/bash', 02:57:01 INFO - 'SHLVL': '1', 02:57:01 INFO - 'TERM': 'linux', 02:57:01 INFO - 'TMOUT': '86400', 02:57:01 INFO - 'USER': 'cltbld', 02:57:01 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:01 INFO - '_': '/tools/buildbot/bin/python'} 02:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:01 INFO - Downloading/unpacking blobuploader==1.2.4 02:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:04 INFO - Downloading blobuploader-1.2.4.tar.gz 02:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:57:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:57:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:05 INFO - Downloading docopt-0.6.1.tar.gz 02:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:57:05 INFO - Installing collected packages: blobuploader, requests, docopt 02:57:05 INFO - Running setup.py install for blobuploader 02:57:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:57:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:57:05 INFO - Running setup.py install for requests 02:57:05 INFO - Running setup.py install for docopt 02:57:05 INFO - Successfully installed blobuploader requests docopt 02:57:05 INFO - Cleaning up... 02:57:05 INFO - Return code: 0 02:57:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:06 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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:57:06 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 02:57:06 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 02:57:06 INFO - Using env: {'DISPLAY': ':0', 02:57:06 INFO - 'HOME': '/home/cltbld', 02:57:06 INFO - 'LANG': 'en_US.UTF-8', 02:57:06 INFO - 'LANGUAGE': 'en_US:en', 02:57:06 INFO - 'LOGNAME': 'cltbld', 02:57:06 INFO - 'MAIL': '/var/mail/cltbld', 02:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:06 INFO - 'MOZ_NO_REMOTE': '1', 02:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:06 INFO - 'NO_EM_RESTART': '1', 02:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:06 INFO - 'PWD': '/builds/slave/test', 02:57:06 INFO - 'SHELL': '/bin/bash', 02:57:06 INFO - 'SHLVL': '1', 02:57:06 INFO - 'TERM': 'linux', 02:57:06 INFO - 'TMOUT': '86400', 02:57:06 INFO - 'USER': 'cltbld', 02:57:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:06 INFO - '_': '/tools/buildbot/bin/python'} 02:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:06 INFO - Running setup.py (path:/tmp/pip-cUt7Qm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:06 INFO - Running setup.py (path:/tmp/pip-BtwXqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:06 INFO - Running setup.py (path:/tmp/pip-O4DTcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:06 INFO - Running setup.py (path:/tmp/pip-T7fzP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:06 INFO - Running setup.py (path:/tmp/pip-mKH7Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:06 INFO - Running setup.py (path:/tmp/pip-9qExLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:06 INFO - Running setup.py (path:/tmp/pip-pwQ2Kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:06 INFO - Running setup.py (path:/tmp/pip-goHj8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:06 INFO - Running setup.py (path:/tmp/pip-QpQbmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:07 INFO - Running setup.py (path:/tmp/pip-x0eDVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:07 INFO - Running setup.py (path:/tmp/pip-npJLOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:07 INFO - Running setup.py (path:/tmp/pip-GqU0Lw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:07 INFO - Running setup.py (path:/tmp/pip-iJCk0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:07 INFO - Running setup.py (path:/tmp/pip-14MCcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:07 INFO - Running setup.py (path:/tmp/pip-hhBOvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:07 INFO - Running setup.py (path:/tmp/pip-HlJjOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:07 INFO - Running setup.py (path:/tmp/pip-ishDTy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:57:07 INFO - Running setup.py install for manifestparser 02:57:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:57:07 INFO - Running setup.py install for mozcrash 02:57:07 INFO - Running setup.py install for mozdebug 02:57:07 INFO - Running setup.py install for mozdevice 02:57:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for mozfile 02:57:08 INFO - Running setup.py install for mozhttpd 02:57:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for mozinfo 02:57:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for mozInstall 02:57:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for mozleak 02:57:08 INFO - Running setup.py install for mozlog 02:57:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for moznetwork 02:57:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for mozprocess 02:57:08 INFO - Running setup.py install for mozprofile 02:57:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:57:08 INFO - Running setup.py install for mozrunner 02:57:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:57:09 INFO - Running setup.py install for mozscreenshot 02:57:09 INFO - Running setup.py install for moztest 02:57:09 INFO - Running setup.py install for mozversion 02:57:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:57:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:57:09 INFO - Cleaning up... 02:57:09 INFO - Return code: 0 02:57:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57:09 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')]} 02:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:09 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')]} 02:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:09 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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:57:09 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 02:57:09 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 02:57:09 INFO - Using env: {'DISPLAY': ':0', 02:57:09 INFO - 'HOME': '/home/cltbld', 02:57:09 INFO - 'LANG': 'en_US.UTF-8', 02:57:09 INFO - 'LANGUAGE': 'en_US:en', 02:57:09 INFO - 'LOGNAME': 'cltbld', 02:57:09 INFO - 'MAIL': '/var/mail/cltbld', 02:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:09 INFO - 'MOZ_NO_REMOTE': '1', 02:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:09 INFO - 'NO_EM_RESTART': '1', 02:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:09 INFO - 'PWD': '/builds/slave/test', 02:57:09 INFO - 'SHELL': '/bin/bash', 02:57:09 INFO - 'SHLVL': '1', 02:57:09 INFO - 'TERM': 'linux', 02:57:09 INFO - 'TMOUT': '86400', 02:57:09 INFO - 'USER': 'cltbld', 02:57:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:09 INFO - '_': '/tools/buildbot/bin/python'} 02:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:57:09 INFO - Running setup.py (path:/tmp/pip-tLzAPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:57:09 INFO - Running setup.py (path:/tmp/pip-L3OJ5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:57:09 INFO - Running setup.py (path:/tmp/pip-DomFt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:57:10 INFO - Running setup.py (path:/tmp/pip-lGsdpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:57:10 INFO - Running setup.py (path:/tmp/pip-BPIrAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:57:10 INFO - Running setup.py (path:/tmp/pip-x6mTrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:57:10 INFO - Running setup.py (path:/tmp/pip-pWjCS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:57:10 INFO - Running setup.py (path:/tmp/pip-tmv1eD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:57:10 INFO - Running setup.py (path:/tmp/pip-Osjg22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:57:10 INFO - Running setup.py (path:/tmp/pip-DJ1LL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:57:10 INFO - Running setup.py (path:/tmp/pip-atL0P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:57:10 INFO - Running setup.py (path:/tmp/pip-ptZ5FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:57:10 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)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:57:10 INFO - Running setup.py (path:/tmp/pip-cT4HR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:57:10 INFO - Running setup.py (path:/tmp/pip-ciAkWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:10 INFO - Running setup.py (path:/tmp/pip-QemHLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:57:10 INFO - Running setup.py (path:/tmp/pip-Eat_PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:57:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:57:10 INFO - Running setup.py (path:/tmp/pip-OcBPqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:57:11 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)) 02:57:11 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)) 02:57:11 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)) 02:57:11 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)) 02:57:11 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)) 02:57:11 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)) 02:57:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:57:11 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 02:57:11 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 02:57:11 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 02:57:11 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 02:57:11 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 02:57:11 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 02:57:12 INFO - Downloading blessings-1.6.tar.gz 02:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:57:13 INFO - Installing collected packages: blessings 02:57:13 INFO - Running setup.py install for blessings 02:57:13 INFO - Successfully installed blessings 02:57:13 INFO - Cleaning up... 02:57:13 INFO - Return code: 0 02:57:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:13 INFO - Reading from file tmpfile_stdout 02:57:13 INFO - Current package versions: 02:57:13 INFO - argparse == 1.2.1 02:57:13 INFO - blessings == 1.6 02:57:13 INFO - blobuploader == 1.2.4 02:57:13 INFO - docopt == 0.6.1 02:57:13 INFO - functools32 == 3.2.3-2 02:57:13 INFO - jsonschema == 2.5.1 02:57:13 INFO - manifestparser == 1.1 02:57:13 INFO - mozInstall == 1.12 02:57:13 INFO - mozcrash == 0.17 02:57:13 INFO - mozdebug == 0.1 02:57:13 INFO - mozdevice == 0.48 02:57:13 INFO - mozfile == 1.2 02:57:13 INFO - mozhttpd == 0.7 02:57:13 INFO - mozinfo == 0.9 02:57:13 INFO - mozleak == 0.1 02:57:13 INFO - mozlog == 3.4 02:57:13 INFO - moznetwork == 0.27 02:57:13 INFO - mozprocess == 0.23 02:57:13 INFO - mozprofile == 0.28 02:57:13 INFO - mozrunner == 6.12 02:57:13 INFO - mozscreenshot == 0.1 02:57:13 INFO - mozsystemmonitor == 0.3 02:57:13 INFO - moztest == 0.7 02:57:13 INFO - mozversion == 1.4 02:57:13 INFO - psutil == 3.1.1 02:57:13 INFO - requests == 1.2.3 02:57:13 INFO - wsgiref == 0.1.2 02:57:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:13 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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:57:13 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 02:57:13 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 02:57:13 INFO - Using env: {'DISPLAY': ':0', 02:57:13 INFO - 'HOME': '/home/cltbld', 02:57:13 INFO - 'LANG': 'en_US.UTF-8', 02:57:13 INFO - 'LANGUAGE': 'en_US:en', 02:57:13 INFO - 'LOGNAME': 'cltbld', 02:57:13 INFO - 'MAIL': '/var/mail/cltbld', 02:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:13 INFO - 'MOZ_NO_REMOTE': '1', 02:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:13 INFO - 'NO_EM_RESTART': '1', 02:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:13 INFO - 'PWD': '/builds/slave/test', 02:57:13 INFO - 'SHELL': '/bin/bash', 02:57:13 INFO - 'SHLVL': '1', 02:57:13 INFO - 'TERM': 'linux', 02:57:13 INFO - 'TMOUT': '86400', 02:57:13 INFO - 'USER': 'cltbld', 02:57:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:13 INFO - '_': '/tools/buildbot/bin/python'} 02:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 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)) 02:57:13 INFO - Cleaning up... 02:57:13 INFO - Return code: 0 02:57:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:57: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')]} 02:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57: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')]} 02:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:13 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 0x7f223e744f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ab9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', '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 02:57:13 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 02:57:13 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 02:57:13 INFO - Using env: {'DISPLAY': ':0', 02:57:13 INFO - 'HOME': '/home/cltbld', 02:57:13 INFO - 'LANG': 'en_US.UTF-8', 02:57:13 INFO - 'LANGUAGE': 'en_US:en', 02:57:13 INFO - 'LOGNAME': 'cltbld', 02:57:13 INFO - 'MAIL': '/var/mail/cltbld', 02:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:13 INFO - 'MOZ_NO_REMOTE': '1', 02:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:13 INFO - 'NO_EM_RESTART': '1', 02:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:13 INFO - 'PWD': '/builds/slave/test', 02:57:13 INFO - 'SHELL': '/bin/bash', 02:57:13 INFO - 'SHLVL': '1', 02:57:13 INFO - 'TERM': 'linux', 02:57:13 INFO - 'TMOUT': '86400', 02:57:13 INFO - 'USER': 'cltbld', 02:57:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:13 INFO - '_': '/tools/buildbot/bin/python'} 02:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:57:13 INFO - Cleaning up... 02:57:13 INFO - Return code: 0 02:57:13 INFO - Running post-action listener: _resource_record_post_action 02:57:13 INFO - Running post-action listener: _start_resource_monitoring 02:57:14 INFO - Starting resource monitoring. 02:57:14 INFO - [mozharness: 2016-10-25 09:57:14.014121Z] Finished create-virtualenv step (success) 02:57:14 INFO - [mozharness: 2016-10-25 09:57:14.014621Z] Running install step. 02:57:14 INFO - Running pre-action listener: _resource_record_pre_action 02:57:14 INFO - Running main action method: install 02:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:57:14 INFO - Reading from file tmpfile_stdout 02:57:14 INFO - Detecting whether we're running mozinstall >=1.0... 02:57:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:57:14 INFO - Reading from file tmpfile_stdout 02:57:14 INFO - Output received: 02:57:14 INFO - Usage: mozinstall [options] installer 02:57:14 INFO - Options: 02:57:14 INFO - -h, --help show this help message and exit 02:57:14 INFO - -d DEST, --destination=DEST 02:57:14 INFO - Directory to install application into. [default: 02:57:14 INFO - "/builds/slave/test"] 02:57:14 INFO - --app=APP Application being installed. [default: firefox] 02:57:14 INFO - mkdir: /builds/slave/test/build/application 02:57:14 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'] 02:57:14 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 02:57:30 INFO - Reading from file tmpfile_stdout 02:57:30 INFO - Output received: 02:57:30 INFO - /builds/slave/test/build/application/firefox/firefox 02:57:30 INFO - Running post-action listener: _resource_record_post_action 02:57:30 INFO - [mozharness: 2016-10-25 09:57:30.351726Z] Finished install step (success) 02:57:30 INFO - [mozharness: 2016-10-25 09:57:30.351974Z] Running run-tests step. 02:57:30 INFO - Running pre-action listener: _resource_record_pre_action 02:57:30 INFO - Running main action method: run_tests 02:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:57:30 INFO - Python 2.7.3 02:57:30 INFO - Return code: 0 02:57:30 INFO - grabbing minidump binary from tooltool 02:57:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:57:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ab6f60>, '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 0x2ab7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ab81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:57:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:57:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:57:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:57:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:57:30 INFO - Return code: 0 02:57:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:57:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:57:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:57:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:57:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:57:30 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/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 02:57:30 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/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 02:57:30 INFO - Using env: {'DISPLAY': ':0', 02:57:30 INFO - 'HOME': '/home/cltbld', 02:57:30 INFO - 'LANG': 'en_US.UTF-8', 02:57:30 INFO - 'LANGUAGE': 'en_US:en', 02:57:30 INFO - 'LOGNAME': 'cltbld', 02:57:30 INFO - 'MAIL': '/var/mail/cltbld', 02:57:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:57:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:30 INFO - 'MOZ_NO_REMOTE': '1', 02:57:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:57:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:30 INFO - 'NO_EM_RESTART': '1', 02:57:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:30 INFO - 'PWD': '/builds/slave/test', 02:57:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:57:30 INFO - 'SHELL': '/bin/bash', 02:57:30 INFO - 'SHLVL': '1', 02:57:30 INFO - 'TERM': 'linux', 02:57:30 INFO - 'TMOUT': '86400', 02:57:30 INFO - 'USER': 'cltbld', 02:57:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340', 02:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:30 INFO - '_': '/tools/buildbot/bin/python'} 02:57:30 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/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 02:57:30 INFO - mozversion application_buildid: 20161025012704 02:57:30 INFO - mozversion application_changeset: 9fb2ac0875ec35268701dd3826b017a301cc7400 02:57:30 INFO - mozversion application_display_name: Nightly 02:57:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:57:30 INFO - mozversion application_name: Firefox 02:57:30 INFO - mozversion application_remotingname: firefox 02:57:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:57:30 INFO - mozversion application_vendor: Mozilla 02:57:30 INFO - mozversion application_version: 52.0a1 02:57:30 INFO - mozversion platform_buildid: 20161025012704 02:57:30 INFO - mozversion platform_changeset: 9fb2ac0875ec35268701dd3826b017a301cc7400 02:57:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:57:30 INFO - mozversion platform_version: 52.0a1 02:57:30 INFO - using testdate: 1477389450 02:57:30 INFO - actual date: 1477389450 02:57:30 INFO - starting webserver on 'localhost:40866' 02:57:30 INFO - SUITE-START | Running 2 tests 02:57:30 INFO - TEST-START | dromaeo_css 02:57:30 INFO - operating with platform_type : linux_ 02:57:30 INFO - Initialising browser for dromaeo_css test... 02:57:30 INFO - TEST-INFO | started process 31878 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfozsbn/profile http://localhost:40866/getInfo.html) 02:57:35 INFO - PROCESS | 31878 | __metrics Screen width/height:1600/1200 02:57:35 INFO - PROCESS | 31878 | colorDepth:24 02:57:35 INFO - PROCESS | 31878 | Browser inner width/height: 1024/697 02:57:35 INFO - PROCESS | 31878 | __metrics 02:57:35 INFO - PROCESS | 31878 | 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" 02:57:35 INFO - PROCESS | 31878 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:57:36 INFO - PROCESS | 31878 | console.error: PushService: 02:57:36 INFO - PROCESS | 31878 | stateChangeProcessEnqueue: Error transitioning state 02:57:36 INFO - PROCESS | 31878 | UnknownError 02:57:37 INFO - TEST-INFO | 31878: exit 0 02:57:37 INFO - Browser initialized. 02:57:37 INFO - Running cycle 1/1 for dromaeo_css test... 02:57:37 INFO - TEST-INFO | started process 31961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfozsbn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:49 INFO - PROCESS | 31961 | RSS: Main: 173461504 02:57:49 INFO - PROCESS | 31961 | 02:58:40 INFO - PROCESS | 31961 | 1477389520721 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] 03:00:55 INFO - PROCESS | 31961 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40866/tests/dromaeo/cssquery-ext.html) 03:00:56 INFO - PROCESS | 31961 | RSS: Main: 307798016 03:00:56 INFO - PROCESS | 31961 | 03:03:59 INFO - PROCESS | 31961 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-ext.html (next: http://localhost:40866/tests/dromaeo/cssquery-jquery.html) 03:03:59 INFO - PROCESS | 31961 | RSS: Main: 278654976 03:03:59 INFO - PROCESS | 31961 | 03:07:02 INFO - PROCESS | 31961 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40866/tests/dromaeo/cssquery-mootools.html) 03:07:02 INFO - PROCESS | 31961 | RSS: Main: 217366528 03:07:02 INFO - PROCESS | 31961 | 03:10:04 INFO - PROCESS | 31961 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40866/tests/dromaeo/cssquery-prototype.html) 03:10:05 INFO - PROCESS | 31961 | RSS: Main: 218877952 03:10:05 INFO - PROCESS | 31961 | 03:13:08 INFO - PROCESS | 31961 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40866/tests/dromaeo/cssquery-yui.html) 03:13:09 INFO - PROCESS | 31961 | RSS: Main: 218214400 03:13:09 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | Cycle 1(1): loaded http://localhost:40866/tests/dromaeo/cssquery-yui.html (next: http://localhost:40866/tests/dromaeo/cssquery-dojo.html) 03:16:12 INFO - PROCESS | 31961 | RSS: Main: 303951872 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | __start_tp_report 03:16:12 INFO - PROCESS | 31961 | _x_x_mozilla_page_load 03:16:12 INFO - PROCESS | 31961 | _x_x_mozilla_page_load_details 03:16:12 INFO - PROCESS | 31961 | |i|pagename|runs| 03:16:12 INFO - PROCESS | 31961 | |0;dojo.html;2615.1239334822835;2626.382800041991;2650.2181856352368;2673;2682.5439675255207;4652.883677908054;4735.455422626399;4778.068276686044;4782.952170478298;4787.2101103317955;4742.217534106868;4750.216214324632;4759.190937540618;4802.279658051294;4847.491013443581;4356.128774245148;4380.802863871118;4428.512863585003;4440.356148358486;4441.733495990251;4402.07556413152;4454.398656181406;4455.034298192822;4462.286034234523;4484.394606728099;4296.5273819879785;4418.3372494125815;4419.027813880941;4431.889202769924;4512.954870451286;4342.652587793001;4419.45881118355;4420.513743488214;4425.7565833879125;4433.8448154314765;4367.67242456817;4380.9780951095045;4389.934150987738;4391.143726973241;4394.868153955386;4828.782704778258;4860.1737704590305;4882.804687812519;4885.071836351082;4905.533974272438;5142.280080788692;5154.229251369319;5158.380994280673;5158.638895277332;5162.92255616166;5182.585393168538;5184.300119483859;5185.507376799198;5190.688558686491;5250.9737451312885;4656.580907718288;4706.176419126639;4709.858704238878;4720.88197795051;4772.308015337757;5217.426083130853;5227.738613069331;5229;5237.266782650432;5271.762770675329;4969.428515720666;4997.575206107522;5014.749262536931;5016.322796422509;5077.26379674945;4855.077535268288;4894.681845680019;4901.926471102936;5084.56781173597;5095.770690318945;5002.52476014778;5026.321446604735;5056.494350564988;5121.052605268037;5123.359580052494;5044.218146187347;5047.495250474996;5048.066107770074;5054.039732450822;5093.8726531836255;4241.703080784316;4242.851500197478;4251.149770046003;4287.464066991626;4298.376735373354;3634.2913131939017;3649.033006253345;3684.1710615111388;3689.594144644087;3699.056740531147;4356.825726970949;4360.607545320873;4363.541828108003;4406.096750166208;4413.977930110329;5000.324956130876;5046.697198168122;5048.495150484996;5058.215976523645;5101.260317254051;4281.357796330575;4291;4353.804078816461;4354.216241076637;4402.581754733295;4492.438445194351;4499.0776890737325;4513.480949690827;4520.028193938319;4566.70316429431;4796.8081276748535;4797.088553174885;4798.304245884327;4801.639877009308;4866.853994380174;5090.160123579568;5093.032323858455;5098.260752190986;5101.51535604117;5157.742112894265;4656.906861862812;4717.457492388282;4721.197396442544;4818.494058123846;4874.756262186947;5113.92329115071;5115.386153661584;5118.436971933159;5171.482851714949;5181.222816577543;5148.536631703165;5183.533481986639;5194.740262986911;5197.7661005254095;5261.237120617566;4750.239961606127;4801.279808028684;4810.975945120252;4998.775055122455;5011.248312753116;5022.422421421583;5041.420236672683;5060.987802439453;5063.8480845574695;5120.487951204998;4930.063287975273;4963.329950456642;4970.3290055842;4972.477889821516;5037.798488060436;4885.022995400863;4945.752712364296;5081.136206844772;5098.872528186825;5101.591872650253;4878.146324393146;4882;4923.950760492493;4927.310176575211;4940.135476291706 03:16:12 INFO - PROCESS | 31961 | |1;ext.html;558.927339445872;563.2199403825701;568.6701713006454;578.5660754434174;583.4020129367401;27924;37992;39289.80355098227;39325.410118848165;42782.358264625975;39253.41119883197;39674.40488392669;39712;39733.40399894004;39757.60242397575;7589.051368578914;7665.923340766577;7680.500767450126;7684.577348245844;7684.9615751921165;7575.696972121109;7655.119661238945;7659.961700191491;7663.540187588735;7664.348530374925;7653.272939070779;7705.499142555744;7727.768166955;7729.7681069567725;7735.574543400111;7676.961615191916;7731.072271327421;7732.072151341818;7744.225577442267;7746.9225307746765;7600.2779735925;7605.619719014027;7670.041244844395;7672.194419585975;7681.615919204018;36976.81511592425;37142.8142859284;37203.62796372029;37237.441438378446;37782.24435511302;2894.13176047185;2993.5125578700786;3013.560523255523;3050.496668049769;3168.3504881499466;27550.311242219104;28253.858730706215;28362;28636.570451443244;29371.265718356997;3370.4438767603315;3487.808170550619;3505.071156143624;3515.244222492151;3580.534530511043;225777;226552;227206;228790.99999999834;229003;30126.397472050438;49795.751021245385;50257.70747826568;50285.497145028814;50324.49675503271;30373.24066898301;32525.837370813468;32612.67387326144;32633;32642.347153056806;13140;13253.73492530144;13260.204387736767;13265.80101298462;13269.867301327056;10965.177611679155;11049.613263535899;11065.170112241614;11080.833787493195;11090.168237382228;7595.5822429766895;7658.157602663702;7676.846463070708;7682.1549629540705;7722.304992550585;2996.7752418568257;3019.637643482752;3057.617797775278;3063.417950589381;3064.249258931576;881.6032785246665;881.6870011146079;927.9443233406017;980.7253968888723;981.9852702209473;26775.732242677714;26881.731182688312;27084.86457567739;27846.443071138463;27905.441891162063;939.5208443693765;947.5972711597543;950.9144177024101;961.2022021721954;995.4674249276748;13403.195808251536;14239.715205695828;14429.567112986628;14444.927775361057;14653;350308;354259;356238;356450;356492;46369.30446043312;46717.299240510736;46906.29640555394;46921;46948;1056.1339701444895;1080.330195278932;1125.763589646167;1162.651204638622;1174.2581073194187;26626.334341641614;28275.858620707586;29060.12819615415;29211.7078829209;29266.561001585418;39954.60045399509;40341.59658403378;40354;40415;40424;276368;277452;277531;278399;278533;23478.882605586863;24282.757172428755;24358.75641243565;24380.6342904853;24506.754932450447;39710.20579588334;39860.80069599633;40049;40495.392569112075;40848;34352.141196470286;34480;34896.65103348934;34948;35024.64975350214;33294;33434.66565334315;33481.83259083689;33818.49272260967;33829.154271143416;29598.852005739835;29949.550756739103;34592.308153837286;34642.82678586591;34765.65234347624;28555.571666424607;31214.2073231571;35061.649383505835;35497.64502355047;35525.82237088798;24689.62965555482;24827.255182344557;24923;24996;25253.24240272795 03:16:12 INFO - PROCESS | 31961 | |2;jquery.html;357.7102546936981;364.63354328899453;366.7671028896651;380.106749139522;383.31960769633895;15630.140342281184;16652.750208746864;17501.649967000652;17585.120743962816;17588.912055439705;16166.272517736701;16223.675526489464;17127.74308385375;17225;17273.91363043183;4860.829870954526;5081.491850814908;5105.310783044297;5112.923306150411;5123.743812809364;3702.3705969985167;3906.570277269512;5013.849584512453;5693.886122277552;5985.730642121115;6058.030715085587;6064.575479716422;6065.666388348639;6066.211392518966;6069.848253793669;5829.154772557977;5998.1602575639445;5999.490043346299;6011;6021.759129634787;4555.794989225493;5284.947150528523;5287.920681189786;5293.576513878919;5294.655847369909;11829;12161.479815023122;12175.573854915036;12176.452059657337;12179.451924663412;1842.0513435580688;1850.6206227723285;1966.9409917702492;2044.7750747417772;2270.2167752125492;8821.558922053871;8843.60203790831;9018.503982280972;9140.223081038053;9271.304652151048;1625.7805196298466;1711.7860267466567;1719.6216832296875;1738.3481194552044;1738.7478815571671;59791;60261.69869150626;61509.384906150815;63338.54913939241;63609.36390636127;9614.71155865325;9659.227261819178;9850.50747462624;9962.750931226632;10026.899731002743;13258.73482530344;13277.93361033208;13298;13314.201147931155;13315.201087934754;6744.426723728538;6796.728130874809;6991.196012458632;7120.145582530129;7225.747098851515;6353.5386861022225;6441.227052753606;6499.772507962293;6518.44593209573;6801.1158549388265;4147.336426171798;4209.894752631209;4226.17589570037;4339.956600434019;4356.390105385249;1517.9165145917082;1630.5434478346083;1742.5120966129505;1773.5743421578727;1853.8053504382115;705.9152901651732;803.1326167738945;824.2169938558394;835.6573804740027;845.306848384319;14918;15351.462698805712;15479.613009674624;15549.144797036271;16409.343626254817;777.0531448847287;791.1376599506566;801.8396320735759;803.1446509467398;819.8647223208224;8512.787180320418;8719;9032.548372581345;9045.366824322366;9204.815903682023;331000;345889;348253;349088;349744;65820;65868;68076.31923680799;68144;68826.65586672035;851.7870532366908;861.5476874640864;866.9263112635497;868.2012548455436;879.5734068976541;13637.590872273848;13781.862181378057;13800.309984500534;13813.102148360324;14466.20435876037;33231.66768332382;33710.662893370754;33929.321413571095;34117.658823411446;34824.47763283502;43836.561634384525;44116.33825492556;44475;46412;46707.76646116884;6847.315268473113;7024.329134312275;7059.788206353817;7438.62806859644;7526.887096693664;8240.629171687408;9797.461139637388;9881.50592470388;9995.800083998425;10646.627368042082;8490.702825401082;8509.87235191485;8549.487030778173;8771.912280877365;8856.247218986458;9394.67118650844;9547.761305967406;9728.686627305224;9737.561809718722;10018.248631352824;8926.642934282556;9068.546572671208;9122.133397327243;9295.25637948976;9516.286278529;7008.614526200904;7019.508634395544;7033.753818616324;7123.679434425359;7211.747588834365;8468.703595374132;8519.531425771642;8640.956795216236;8777.561121944005;9052.90947090547 03:16:12 INFO - PROCESS | 31961 | |3;mootools.html;1312.6980794417282;1381.5371850430106;1420.85081066488;1678.7985441746978;1697.1683874901294;6418.133551970483;6648.634325112117;7328.706851725925;7890.329322007629;7902.565358905265;7373.557586544811;7636.885446718304;7636.892650565665;7787.260210280015;7824.374050075994;2083.593699228651;2115.3971118231307;2123.62836503612;2125.234915430444;2125.256160343875;1795.6139430022542;1853.0456814740419;2075.647139986206;2119.3218170185546;2158.125958986613;1842.1802297977406;1866.094943952189;1868.2900497810813;2047.948801279965;2112.419084751698;2014.5064459207515;2015.042854644047;2016.2539860251654;2028.3103744726864;2028.8782673039666;1997.1412292714126;1997.5205950571903;2005.6089062632793;2033.8779673219653;2034.8575599708026;7880.014998125234;7908.80227994299;7927.5243485391065;7942.285194332538;7973.122956474783;4418.851098714325;4473.9105217895785;4528.864134075983;4537.478190008158;4541.45502539694;2793.539066054099;2881.812682175652;2883.6972117927735;2914.5191043477803;2944.5877577139217;894.3873446689039;931.4318265857821;935.2237642756496;949.8290307744603;952.6998995316453;10568.788624227473;10618.309809862334;10619.681409557648;10636.414997175152;10644.946775266151;3957.1689945111275;3979.721419500665;4101.774402407897;4213.157368526307;4231.2172248133575;8969.730908072768;8987.730368088967;8995.145461181177;9000.459972401677;9003.639854405881;4575.176468235683;4603.49361570227;4607.792649330788;4612.815487380534;4613.308003799457;4140.772257525805;4228.788560571959;4230.471191101113;4230.598093181205;4232.343986682069;3583.211693427442;3623.474596183539;3682.5949145593963;3696.149885526344;3710.962890371062;1118.552578968419;1173.7769823733463;1179.9351035693119;1180.7461395799944;1186.9703257418635;778.8014056415577;799.580220384303;801.2628381888676;809.8704207326799;823.2097186700714;4627.768611569408;4647.814087436464;4753.619710423158;4756.904861902743;4947.529984651453;377.6167190301846;388.07637821983496;394.07589203318173;399.3650096346764;401.6164562842537;3232.725218356419;3429.6913277805115;3746.38184699527;3870.748401353903;3883.5339759229073;9272.953635231916;9459.621615135455;9487.573059212353;9565.378250413702;9569.186619137452;9454.810903782023;9470.384425012353;9473.810523789623;9484.525773711286;9484.762880928032;6849.109615750021;7167.139943206848;7345.669444874993;7346.706131754777;7350.117985841626;5502.202180683698;5505.972470137784;5631.521320687623;5706.28671416073;5867.794627188028;8435.186434916523;8567.357448191286;8750.431221970552;8758.956205218934;8780.341474389319;8807.427517211361;8897.065808090058;9022.593983270637;9063.184313411824;9078.54607269647;6228.065790131516;6370.713317900798;6404.1674582304;6528.804135875931;6664.033715111184;7169.928300717134;7220.494565380373;7221.205667376479;7228.385587225145;7234.5659260444545;6416.230052393743;6464.5151613630105;6501.544891857714;6504.902426463512;6634.83412914681;6383.0744542042075;6391.776287829904;6451.032345148265;6475.093486911742;6613.14029176204;5982.4316689914385;6067.029275315928;6071.119687645355;6073.635581865102;6077.908831367621;4080.6327430531396;4127.174565086934;4137.40007698888;4257.297545904891;4309.719868208556;4016.638502534786;4017;4024.7786371749835;4146.129312844216;4208.074223670787 03:16:12 INFO - PROCESS | 31961 | |4;prototype.html;277.49218929359273;297.29540987858775;300.5701846359705;300.706810859412;303.6508015781852;4733.408323959505;4833.250846118857;4893.241547560129;4897.706137631744;4909.852704418869;4740.791098269945;4795.496472870351;4799.376081109451;4808.663393562452;4819.662623616348;3543.6456354364614;3666.7066634669295;3674.4488326751066;3777.490038844748;3789.147441825595;3757.2861156380336;3764.1530655602405;3765.548134223883;3777.7922214278206;3790.9810450947843;3719.79541125238;3727.5526936767624;3731.2350968051483;3731.9067023324496;3732.581618984782;3538.964610353915;3614.5662520497444;3639.29033838399;3742.419924911643;3755.192633583779;3259.4784834426378;3259.6740325967453;3263.233140212048;3272.885449009297;3280.5407242986003;4638.837640682594;4675.625949923998;4683.899283668336;4696.835610753641;4698.801805539566;4161.25097482456;4262.87211383659;4266.786660666985;4268.59448352406;4270.12462445198;4957.107720610289;4974.452810190876;4975.7263350515705;4991.425986011583;4994.725290109042;3545.592256890465;3547.343741407848;3552.2540266544056;3553.289342131558;3555.928881422357;5224.660397074178;5227.47725227478;5232.372115346183;5243.404514765216;5244.60665450089;3452.533907922398;3618.3125206210734;3624.3657359961903;3648.416253399443;3650.9634903651154;3687.94468082979;3691.206390626028;3691.630836916287;3698.6671199592165;3706.4625629283605;4202.579742025773;4218.261804184317;4224;4246.596573325529;4247.256730072287;4878.95121048792;4950.612994490538;4991.850244492671;5036.169032109661;5049.697018178921;1210.5581462766027;1235.5057976809348;1240.6030070377574;1241.7392347607104;1242.6147894152841;803.1091940615534;805.472415567804;826.8259072117608;828.9212524810254;834.5701963488808;4005.218982298482;4012.7191096622955;4266.168097221074;4384.758838263926;4399.626031787334;5010.549050585465;5036.179739345905;5046.823361182341;5058.140116180258;5083.822066227738;4479.507254202035;4484.910301793946;4488.438945131858;4490.438695163105;4514.367988481549;2618.4763047390597;2727.4726153354186;2732.8496932668895;2750.752432281104;2751.7110703376256;4890.462049174588;4890.82882099132;4890.926636100461;4894.388201474816;4901.5343542364135;5288;5290.65610735301;5293.814716484904;5300.231466437422;5306.681599103988;4735.147673418749;4791.976040119777;4805.8558243252755;4859.975700121477;4909.239067944474;5084.618653601069;5094.420729573844;5135.3324067870935;5160.716160611202;5173.689578625294;4986.501349864984;5026.547610715053;5059.5952323814745;5110.66780659256;5116.565091967224;4757.809687612456;4802.455688682076;4892.535209155125;4907.975460122677;4931.3589233399425;3579.9463008055423;3633.000924745716;3634;3637.7445983490406;3642.927141457103;5103.413107492686;5128.3076784633595;5138.922916156186;5171.793128274827;5176.275321454924;4800;4919.44103163423;4924.8276310328965;4953.628477864103;4963.7911129547;4939.580135688507;4942.7034377936;4982.427020892644;5013.824516141917;5022.522860328263;4933.741895816544;4942.57988071018;4955.8017679292425;4959.776810043484;4967.528084831935;4813.278008298783;4819.2530157825595;5044.4198917125;5054.78685115577;5087.872803179802;4792.376990991149;4865.756712164307;4941.728204948762;4944.258361245842;4952.579030782424 03:16:12 INFO - PROCESS | 31961 | |5;yui.html;630.8832865919803;720.7117153138744;733.512214377439;739.2792027772919;760.1831622422411;12567.434465449054;13549.593512194637;13568.592942211724;13573.253471059088;13593.048486605941;12743.936280318609;13186.604401867959;13214;13460.394282257297;13465.394057267422;783.6160281462099;806.1454857850697;807.858624740671;807.9555624440653;808.4381354958306;618.9350118237588;631.409631994087;765.7396485195032;796.3549524884833;798.2336956521746;825.9215374539409;829.0258945738763;829.0424559633633;835.807764214231;835.8286551257008;823.2672921100195;826.3760860550276;827.3422629009951;828.0601517277872;828.4656396624143;473.19084365734636;476.28794951547656;590.9586328956975;612.5405945540845;612.8100288910407;12585.056120790978;13045.478180872753;13164.736705265937;13217.603471895858;13277.668058298523;11979.520819167223;12136.15046946714;12362;12666;12725.872741272562;11570.768584628344;11620.709482263012;11654.592089276919;11730.296182229093;11742.823857642143;4025.75845449274;4056.858009969637;4059.0664147246002;4093.1199792044554;4139.5653456387245;60414.39585604176;61033.694831526445;61169;61389.07916381258;61797.6910115451;9704.805903881883;9805.313628046111;10057.497125143713;10513.737156571147;10562.471876406149;17797.822021779877;17877.37429189972;17904;17904.641907161782;17981.1009449527;6399.8080057598345;6622.96688516564;6677.899831502531;6726.125603671491;6937.583744975318;3170.2391426058043;3404.863805447754;3600.3519366513756;3603.891883243507;3613.602503724588;2725.8909643614033;2849.187981425284;2861.2703760541344;3170.651228364878;3317.3531161423775;553.4354957942876;558.7485631465856;569.4931510955253;577.096843440015;584.1442287049408;505.75723652646934;606.7027156693189;613.1416017575341;621.586644881149;623.4700504571078;7878.172791856887;7894.486858354188;8493.278071364004;8710.825783484295;8733.956330218309;459.7264627546671;512.8000079968815;546.7840203119746;599.4544964082664;600.1927407636722;3835.7907714333696;3980.3432433648704;4097.610726980932;4102.630763231324;4190.476190476191;73484.63257683677;87849.56075219583;100443.49778251062;100978;101662.49168754109;48160.27759583609;48935.26597101046;49019.26471102936;53929.1910621341;83256.58371708103;56227.71886140543;73997;75830;76103;77207.61396192871;7476.140243871807;7482.326590606872;7489.588072656056;7550.018497595277;7793.766187014398;45170.32244516269;45694.771526142154;46939.295910560686;47526.52473475221;47926.760366197945;59746;63997.68001160151;64569.35430645821;65027.34972650213;67972.660136699;9353.579088941151;9373.343865929592;9377.390469619453;9566.378185417925;9817.116459518393;10864.185186111232;12139.332336721565;12337.876621234032;12362.44369003415;13602.183868967893;11949.283043017447;12207.206531575419;12382.257064576153;12484.750304994031;12884.291363975071;10583.4708264588;11034;11253.831192531954;11953.462094205608;12356.443960021641;11209;11621.477033533341;11693.415329233674;11753.647390578297;12348.567800126952;9241.445513269226;9335.299852510952;9996.450195239331;10054.447005414773;10146.188304935735;9685.601894513818;10096.725857116451;10124.387035043877;10128.572565878467;10165.898341016495 03:16:12 INFO - PROCESS | 31961 | __end_tp_report 03:16:12 INFO - PROCESS | 31961 | __start_cc_report 03:16:12 INFO - PROCESS | 31961 | _x_x_mozilla_cycle_collect,1381 03:16:12 INFO - PROCESS | 31961 | __end_cc_report 03:16:12 INFO - PROCESS | 31961 | __startTimestamp1477390572713__endTimestamp 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | ------- Summary: start ------- 03:16:12 INFO - PROCESS | 31961 | Number of tests: 6 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | [#0] dojo.html Cycles:165 Average:4715.44 Median:4855.08 stddev:510.21 (10.5%) stddev-sans-first:484.44 03:16:12 INFO - PROCESS | 31961 | Values: 2615.1 2626.4 2650.2 2673.0 2682.5 4652.9 4735.5 4778.1 4783.0 4787.2 4742.2 4750.2 4759.2 4802.3 4847.5 4356.1 4380.8 4428.5 4440.4 4441.7 4402.1 4454.4 4455.0 4462.3 4484.4 4296.5 4418.3 4419.0 4431.9 4513.0 4342.7 4419.5 4420.5 4425.8 4433.8 4367.7 4381.0 4389.9 4391.1 4394.9 4828.8 4860.2 4882.8 4885.1 4905.5 5142.3 5154.2 5158.4 5158.6 5162.9 5182.6 5184.3 5185.5 5190.7 5251.0 4656.6 4706.2 4709.9 4720.9 4772.3 5217.4 5227.7 5229.0 5237.3 5271.8 4969.4 4997.6 5014.7 5016.3 5077.3 4855.1 4894.7 4901.9 5084.6 5095.8 5002.5 5026.3 5056.5 5121.1 5123.4 5044.2 5047.5 5048.1 5054.0 5093.9 4241.7 4242.9 4251.1 4287.5 4298.4 3634.3 3649.0 3684.2 3689.6 3699.1 4356.8 4360.6 4363.5 4406.1 4414.0 5000.3 5046.7 5048.5 5058.2 5101.3 4281.4 4291.0 4353.8 4354.2 4402.6 4492.4 4499.1 4513.5 4520.0 4566.7 4796.8 4797.1 4798.3 4801.6 4866.9 5090.2 5093.0 5098.3 5101.5 5157.7 4656.9 4717.5 4721.2 4818.5 4874.8 5113.9 5115.4 5118.4 5171.5 5181.2 5148.5 5183.5 5194.7 5197.8 5261.2 4750.2 4801.3 4811.0 4998.8 5011.2 5022.4 5041.4 5061.0 5063.8 5120.5 4930.1 4963.3 4970.3 4972.5 5037.8 4885.0 4945.8 5081.1 5098.9 5101.6 4878.1 4882.0 4924.0 4927.3 4940.1 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | [#1] ext.html Cycles:180 Average:42918.73 Median:192666.32 stddev:76662.50 (39.8%) stddev-sans-first:76811.58 03:16:12 INFO - PROCESS | 31961 | Values: 558.9 563.2 568.7 578.6 583.4 27924.0 37992.0 39289.8 39325.4 42782.4 39253.4 39674.4 39712.0 39733.4 39757.6 7589.1 7665.9 7680.5 7684.6 7685.0 7575.7 7655.1 7660.0 7663.5 7664.3 7653.3 7705.5 7727.8 7729.8 7735.6 7677.0 7731.1 7732.1 7744.2 7746.9 7600.3 7605.6 7670.0 7672.2 7681.6 36976.8 37142.8 37203.6 37237.4 37782.2 2894.1 2993.5 3013.6 3050.5 3168.4 27550.3 28253.9 28362.0 28636.6 29371.3 3370.4 3487.8 3505.1 3515.2 3580.5 225777.0 226552.0 227206.0 228791.0 229003.0 30126.4 49795.8 50257.7 50285.5 50324.5 30373.2 32525.8 32612.7 32633.0 32642.3 13140.0 13253.7 13260.2 13265.8 13269.9 10965.2 11049.6 11065.2 11080.8 11090.2 7595.6 7658.2 7676.8 7682.2 7722.3 2996.8 3019.6 3057.6 3063.4 3064.2 881.6 881.7 927.9 980.7 982.0 26775.7 26881.7 27084.9 27846.4 27905.4 939.5 947.6 950.9 961.2 995.5 13403.2 14239.7 14429.6 14444.9 14653.0 350308.0 354259.0 356238.0 356450.0 356492.0 46369.3 46717.3 46906.3 46921.0 46948.0 1056.1 1080.3 1125.8 1162.7 1174.3 26626.3 28275.9 29060.1 29211.7 29266.6 39954.6 40341.6 40354.0 40415.0 40424.0 276368.0 277452.0 277531.0 278399.0 278533.0 23478.9 24282.8 24358.8 24380.6 24506.8 39710.2 39860.8 40049.0 40495.4 40848.0 34352.1 34480.0 34896.7 34948.0 35024.6 33294.0 33434.7 33481.8 33818.5 33829.2 29598.9 29949.6 34592.3 34642.8 34765.7 28555.6 31214.2 35061.6 35497.6 35525.8 24689.6 24827.3 24923.0 24996.0 25253.2 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | [#2] jquery.html Cycles:180 Average:21737.76 Median:5998.83 stddev:56884.05 (948.3%) stddev-sans-first:57020.97 03:16:12 INFO - PROCESS | 31961 | Values: 357.7 364.6 366.8 380.1 383.3 15630.1 16652.8 17501.6 17585.1 17588.9 16166.3 16223.7 17127.7 17225.0 17273.9 4860.8 5081.5 5105.3 5112.9 5123.7 3702.4 3906.6 5013.8 5693.9 5985.7 6058.0 6064.6 6065.7 6066.2 6069.8 5829.2 5998.2 5999.5 6011.0 6021.8 4555.8 5284.9 5287.9 5293.6 5294.7 11829.0 12161.5 12175.6 12176.5 12179.5 1842.1 1850.6 1966.9 2044.8 2270.2 8821.6 8843.6 9018.5 9140.2 9271.3 1625.8 1711.8 1719.6 1738.3 1738.7 59791.0 60261.7 61509.4 63338.5 63609.4 9614.7 9659.2 9850.5 9962.8 10026.9 13258.7 13277.9 13298.0 13314.2 13315.2 6744.4 6796.7 6991.2 7120.1 7225.7 6353.5 6441.2 6499.8 6518.4 6801.1 4147.3 4209.9 4226.2 4340.0 4356.4 1517.9 1630.5 1742.5 1773.6 1853.8 705.9 803.1 824.2 835.7 845.3 14918.0 15351.5 15479.6 15549.1 16409.3 777.1 791.1 801.8 803.1 819.9 8512.8 8719.0 9032.5 9045.4 9204.8 331000.0 345889.0 348253.0 349088.0 349744.0 65820.0 65868.0 68076.3 68144.0 68826.7 851.8 861.5 866.9 868.2 879.6 13637.6 13781.9 13800.3 13813.1 14466.2 33231.7 33710.7 33929.3 34117.7 34824.5 43836.6 44116.3 44475.0 46412.0 46707.8 6847.3 7024.3 7059.8 7438.6 7526.9 8240.6 9797.5 9881.5 9995.8 10646.6 8490.7 8509.9 8549.5 8771.9 8856.2 9394.7 9547.8 9728.7 9737.6 10018.2 8926.6 9068.5 9122.1 9295.3 9516.3 7008.6 7019.5 7033.8 7123.7 7211.7 8468.7 8519.5 8641.0 8777.6 9052.9 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | [#3] mootools.html Cycles:180 Average:5000.59 Median:4637.79 stddev:2866.31 (61.8%) stddev-sans-first:2860.95 03:16:12 INFO - PROCESS | 31961 | Values: 1312.7 1381.5 1420.9 1678.8 1697.2 6418.1 6648.6 7328.7 7890.3 7902.6 7373.6 7636.9 7636.9 7787.3 7824.4 2083.6 2115.4 2123.6 2125.2 2125.3 1795.6 1853.0 2075.6 2119.3 2158.1 1842.2 1866.1 1868.3 2047.9 2112.4 2014.5 2015.0 2016.3 2028.3 2028.9 1997.1 1997.5 2005.6 2033.9 2034.9 7880.0 7908.8 7927.5 7942.3 7973.1 4418.9 4473.9 4528.9 4537.5 4541.5 2793.5 2881.8 2883.7 2914.5 2944.6 894.4 931.4 935.2 949.8 952.7 10568.8 10618.3 10619.7 10636.4 10644.9 3957.2 3979.7 4101.8 4213.2 4231.2 8969.7 8987.7 8995.1 9000.5 9003.6 4575.2 4603.5 4607.8 4612.8 4613.3 4140.8 4228.8 4230.5 4230.6 4232.3 3583.2 3623.5 3682.6 3696.1 3711.0 1118.6 1173.8 1179.9 1180.7 1187.0 778.8 799.6 801.3 809.9 823.2 4627.8 4647.8 4753.6 4756.9 4947.5 377.6 388.1 394.1 399.4 401.6 3232.7 3429.7 3746.4 3870.7 3883.5 9273.0 9459.6 9487.6 9565.4 9569.2 9454.8 9470.4 9473.8 9484.5 9484.8 6849.1 7167.1 7345.7 7346.7 7350.1 5502.2 5506.0 5631.5 5706.3 5867.8 8435.2 8567.4 8750.4 8759.0 8780.3 8807.4 8897.1 9022.6 9063.2 9078.5 6228.1 6370.7 6404.2 6528.8 6664.0 7169.9 7220.5 7221.2 7228.4 7234.6 6416.2 6464.5 6501.5 6504.9 6634.8 6383.1 6391.8 6451.0 6475.1 6613.1 5982.4 6067.0 6071.1 6073.6 6077.9 4080.6 4127.2 4137.4 4257.3 4309.7 4016.6 4017.0 4024.8 4146.1 4208.1 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | [#4] prototype.html Cycles:180 Average:4147.42 Median:4793.94 stddev:1213.46 (25.3%) stddev-sans-first:1181.59 03:16:12 INFO - PROCESS | 31961 | Values: 277.5 297.3 300.6 300.7 303.7 4733.4 4833.3 4893.2 4897.7 4909.9 4740.8 4795.5 4799.4 4808.7 4819.7 3543.6 3666.7 3674.4 3777.5 3789.1 3757.3 3764.2 3765.5 3777.8 3791.0 3719.8 3727.6 3731.2 3731.9 3732.6 3539.0 3614.6 3639.3 3742.4 3755.2 3259.5 3259.7 3263.2 3272.9 3280.5 4638.8 4675.6 4683.9 4696.8 4698.8 4161.3 4262.9 4266.8 4268.6 4270.1 4957.1 4974.5 4975.7 4991.4 4994.7 3545.6 3547.3 3552.3 3553.3 3555.9 5224.7 5227.5 5232.4 5243.4 5244.6 3452.5 3618.3 3624.4 3648.4 3651.0 3687.9 3691.2 3691.6 3698.7 3706.5 4202.6 4218.3 4224.0 4246.6 4247.3 4879.0 4950.6 4991.9 5036.2 5049.7 1210.6 1235.5 1240.6 1241.7 1242.6 803.1 805.5 826.8 828.9 834.6 4005.2 4012.7 4266.2 4384.8 4399.6 5010.5 5036.2 5046.8 5058.1 5083.8 4479.5 4484.9 4488.4 4490.4 4514.4 2618.5 2727.5 2732.8 2750.8 2751.7 4890.5 4890.8 4890.9 4894.4 4901.5 5288.0 5290.7 5293.8 5300.2 5306.7 4735.1 4792.0 4805.9 4860.0 4909.2 5084.6 5094.4 5135.3 5160.7 5173.7 4986.5 5026.5 5059.6 5110.7 5116.6 4757.8 4802.5 4892.5 4908.0 4931.4 3579.9 3633.0 3634.0 3637.7 3642.9 5103.4 5128.3 5138.9 5171.8 5176.3 4800.0 4919.4 4924.8 4953.6 4963.8 4939.6 4942.7 4982.4 5013.8 5022.5 4933.7 4942.6 4955.8 4959.8 4967.5 4813.3 4819.3 5044.4 5054.8 5087.9 4792.4 4865.8 4941.7 4944.3 4952.6 03:16:12 INFO - PROCESS | 31961 | 03:16:12 INFO - PROCESS | 31961 | [#5] yui.html Cycles:180 Average:16822.31 Median:48547.77 stddev:23374.66 (48.1%) stddev-sans-first:23408.62 03:16:12 INFO - PROCESS | 31961 | Values: 630.9 720.7 733.5 739.3 760.2 12567.4 13549.6 13568.6 13573.3 13593.0 12743.9 13186.6 13214.0 13460.4 13465.4 783.6 806.1 807.9 808.0 808.4 618.9 631.4 765.7 796.4 798.2 825.9 829.0 829.0 835.8 835.8 823.3 826.4 827.3 828.1 828.5 473.2 476.3 591.0 612.5 612.8 12585.1 13045.5 13164.7 13217.6 13277.7 11979.5 12136.2 12362.0 12666.0 12725.9 11570.8 11620.7 11654.6 11730.3 11742.8 4025.8 4056.9 4059.1 4093.1 4139.6 60414.4 61033.7 61169.0 61389.1 61797.7 9704.8 9805.3 10057.5 10513.7 10562.5 17797.8 17877.4 17904.0 17904.6 17981.1 6399.8 6623.0 6677.9 6726.1 6937.6 3170.2 3404.9 3600.4 3603.9 3613.6 2725.9 2849.2 2861.3 3170.7 3317.4 553.4 558.7 569.5 577.1 584.1 505.8 606.7 613.1 621.6 623.5 7878.2 7894.5 8493.3 8710.8 8734.0 459.7 512.8 546.8 599.5 600.2 3835.8 3980.3 4097.6 4102.6 4190.5 73484.6 87849.6 100443.5 100978.0 101662.5 48160.3 48935.3 49019.3 53929.2 83256.6 56227.7 73997.0 75830.0 76103.0 77207.6 7476.1 7482.3 7489.6 7550.0 7793.8 45170.3 45694.8 46939.3 47526.5 47926.8 59746.0 63997.7 64569.4 65027.3 67972.7 9353.6 9373.3 9377.4 9566.4 9817.1 10864.2 12139.3 12337.9 12362.4 13602.2 11949.3 12207.2 12382.3 12484.8 12884.3 10583.5 11034.0 11253.8 11953.5 12356.4 11209.0 11621.5 11693.4 11753.6 12348.6 9241.4 9335.3 9996.5 10054.4 10146.2 9685.6 10096.7 10124.4 10128.6 10165.9 03:16:12 INFO - PROCESS | 31961 | -------- Summary: end -------- 03:16:12 INFO - PROCESS | 31961 | 03:16:13 INFO - TEST-INFO | 31961: exit 0 03:16:13 INFO - TEST-OK | dromaeo_css | took 1123048ms 03:16:13 INFO - TEST-START | kraken 03:16:13 INFO - operating with platform_type : linux_ 03:16:13 INFO - Initialising browser for kraken test... 03:16:13 INFO - TEST-INFO | started process 32268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp81Z0sm/profile http://localhost:40866/getInfo.html) 03:16:17 INFO - PROCESS | 32268 | __metrics Screen width/height:1600/1200 03:16:17 INFO - PROCESS | 32268 | colorDepth:24 03:16:17 INFO - PROCESS | 32268 | Browser inner width/height: 1024/697 03:16:17 INFO - PROCESS | 32268 | __metrics 03:16:18 INFO - PROCESS | 32268 | 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" 03:16:18 INFO - PROCESS | 32268 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:16:19 INFO - PROCESS | 32268 | console.error: PushService: 03:16:19 INFO - PROCESS | 32268 | stateChangeProcessEnqueue: Error transitioning state 03:16:19 INFO - PROCESS | 32268 | UnknownError 03:16:19 INFO - TEST-INFO | 32268: exit 0 03:16:19 INFO - Browser initialized. 03:16:19 INFO - Running cycle 1/1 for kraken test... 03:16:19 INFO - TEST-INFO | started process 32350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp81Z0sm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:16:32 INFO - PROCESS | 32350 | RSS: Main: 173674496 03:16:32 INFO - PROCESS | 32350 | 03:16:34 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-beat-detection) 03:16:35 INFO - PROCESS | 32350 | RSS: Main: 234188800 03:16:35 INFO - PROCESS | 32350 | 03:16:38 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-dft) 03:16:39 INFO - PROCESS | 32350 | RSS: Main: 217120768 03:16:39 INFO - PROCESS | 32350 | 03:16:42 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-fft) 03:16:43 INFO - PROCESS | 32350 | RSS: Main: 298450944 03:16:43 INFO - PROCESS | 32350 | 03:16:45 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40866/tests/kraken/driver.html?testName=audio-oscillator) 03:16:45 INFO - PROCESS | 32350 | RSS: Main: 209866752 03:16:45 INFO - PROCESS | 32350 | 03:16:48 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40866/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:16:48 INFO - PROCESS | 32350 | RSS: Main: 212807680 03:16:48 INFO - PROCESS | 32350 | 03:16:51 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40866/tests/kraken/driver.html?testName=imaging-darkroom) 03:16:52 INFO - PROCESS | 32350 | RSS: Main: 249561088 03:16:52 INFO - PROCESS | 32350 | 03:16:55 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40866/tests/kraken/driver.html?testName=imaging-desaturate) 03:16:56 INFO - PROCESS | 32350 | RSS: Main: 248152064 03:16:56 INFO - PROCESS | 32350 | 03:16:59 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40866/tests/kraken/driver.html?testName=json-parse-financial) 03:16:59 INFO - PROCESS | 32350 | RSS: Main: 247222272 03:16:59 INFO - PROCESS | 32350 | 03:17:01 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40866/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:02 INFO - PROCESS | 32350 | RSS: Main: 210087936 03:17:02 INFO - PROCESS | 32350 | 03:17:03 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:04 INFO - PROCESS | 32350 | RSS: Main: 217927680 03:17:04 INFO - PROCESS | 32350 | 03:17:06 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:07 INFO - PROCESS | 32350 | RSS: Main: 226275328 03:17:07 INFO - PROCESS | 32350 | 03:17:10 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:11 INFO - PROCESS | 32350 | RSS: Main: 234434560 03:17:11 INFO - PROCESS | 32350 | 03:17:14 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:17:14 INFO - PROCESS | 32350 | RSS: Main: 232103936 03:17:14 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | Cycle 1(1): loaded http://localhost:40866/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40866/tests/kraken/driver.html?testName=ai-astar) 03:17:16 INFO - PROCESS | 32350 | RSS: Main: 282189824 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | __start_tp_report 03:17:16 INFO - PROCESS | 32350 | _x_x_mozilla_page_load 03:17:16 INFO - PROCESS | 32350 | _x_x_mozilla_page_load_details 03:17:16 INFO - PROCESS | 32350 | |i|pagename|runs| 03:17:16 INFO - PROCESS | 32350 | |0;ai-astar;105;113;112;114;113;114;112;114;112;113 03:17:16 INFO - PROCESS | 32350 | |1;audio-beat-detection;147;127;129;166;134;134;135;128;159;128 03:17:16 INFO - PROCESS | 32350 | |2;audio-dft;162;161;162;162;163;161;166;161;162;160 03:17:16 INFO - PROCESS | 32350 | |3;audio-fft;77;76;75;112;78;79;76;76;107;76 03:17:16 INFO - PROCESS | 32350 | |4;audio-oscillator;84;84;130;84;83;83;108;83;83;113 03:17:16 INFO - PROCESS | 32350 | |5;imaging-gaussian-blur;117;117;116;117;117;116;117;116;117;117 03:17:16 INFO - PROCESS | 32350 | |6;imaging-darkroom;149;149;148;149;149;148;148;149;149;147 03:17:16 INFO - PROCESS | 32350 | |7;imaging-desaturate;84;85;85;84;84;85;84;84;84;84 03:17:16 INFO - PROCESS | 32350 | |8;json-parse-financial;61;61;61;61;62;64;63;62;63;63 03:17:16 INFO - PROCESS | 32350 | |9;json-stringify-tinderbox;67;66;66;67;67;66;66;67;67;68 03:17:16 INFO - PROCESS | 32350 | |10;stanford-crypto-aes;83;84;83;83;93;88;90;83;84;85 03:17:16 INFO - PROCESS | 32350 | |11;stanford-crypto-ccm;144;144;143;150;146;141;156;137;184;147 03:17:16 INFO - PROCESS | 32350 | |12;stanford-crypto-pbkdf2;183;183;179;176;183;181;185;179;173;177 03:17:16 INFO - PROCESS | 32350 | |13;stanford-crypto-sha256-iterative;70;69;70;69;70;72;70;69;72;70 03:17:16 INFO - PROCESS | 32350 | __end_tp_report 03:17:16 INFO - PROCESS | 32350 | __start_cc_report 03:17:16 INFO - PROCESS | 32350 | _x_x_mozilla_cycle_collect,1943 03:17:16 INFO - PROCESS | 32350 | __end_cc_report 03:17:16 INFO - PROCESS | 32350 | __startTimestamp1477390636691__endTimestamp 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | ------- Summary: start ------- 03:17:16 INFO - PROCESS | 32350 | Number of tests: 14 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 03:17:16 INFO - PROCESS | 32350 | Values: 105.0 113.0 112.0 114.0 113.0 114.0 112.0 114.0 112.0 113.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#1] audio-beat-detection Cycles:10 Average:138.70 Median:134.50 stddev:13.92 (10.4%) stddev-sans-first:14.44 03:17:16 INFO - PROCESS | 32350 | Values: 147.0 127.0 129.0 166.0 134.0 134.0 135.0 128.0 159.0 128.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.63 (1.0%) stddev-sans-first:1.73 03:17:16 INFO - PROCESS | 32350 | Values: 162.0 161.0 162.0 162.0 163.0 161.0 166.0 161.0 162.0 160.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#3] audio-fft Cycles:10 Average:83.20 Median:76.00 stddev:13.96 (18.4%) stddev-sans-first:14.62 03:17:16 INFO - PROCESS | 32350 | Values: 77.0 76.0 75.0 112.0 78.0 79.0 76.0 76.0 107.0 76.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:83.00 stddev:17.11 (20.6%) stddev-sans-first:17.80 03:17:16 INFO - PROCESS | 32350 | Values: 84.0 84.0 130.0 84.0 83.0 83.0 108.0 83.0 83.0 113.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 03:17:16 INFO - PROCESS | 32350 | Values: 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 117.0 117.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:149.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 03:17:16 INFO - PROCESS | 32350 | Values: 149.0 149.0 148.0 149.0 149.0 148.0 148.0 149.0 149.0 147.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 03:17:16 INFO - PROCESS | 32350 | Values: 84.0 85.0 85.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:62.50 stddev:1.10 (1.8%) stddev-sans-first:1.09 03:17:16 INFO - PROCESS | 32350 | Values: 61.0 61.0 61.0 61.0 62.0 64.0 63.0 62.0 63.0 63.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 03:17:16 INFO - PROCESS | 32350 | Values: 67.0 66.0 66.0 67.0 67.0 66.0 66.0 67.0 67.0 68.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:3.53 (4.2%) stddev-sans-first:3.62 03:17:16 INFO - PROCESS | 32350 | Values: 83.0 84.0 83.0 83.0 93.0 88.0 90.0 83.0 84.0 85.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:146.50 stddev:13.26 (9.0%) stddev-sans-first:13.93 03:17:16 INFO - PROCESS | 32350 | Values: 144.0 144.0 143.0 150.0 146.0 141.0 156.0 137.0 184.0 147.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.90 Median:182.00 stddev:3.78 (2.1%) stddev-sans-first:3.84 03:17:16 INFO - PROCESS | 32350 | Values: 183.0 183.0 179.0 176.0 183.0 181.0 185.0 179.0 173.0 177.0 03:17:16 INFO - PROCESS | 32350 | 03:17:16 INFO - PROCESS | 32350 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 03:17:16 INFO - PROCESS | 32350 | Values: 70.0 69.0 70.0 69.0 70.0 72.0 70.0 69.0 72.0 70.0 03:17:16 INFO - PROCESS | 32350 | -------- Summary: end -------- 03:17:16 INFO - PROCESS | 32350 | 03:17:17 INFO - TEST-INFO | 32350: exit 0 03:17:17 INFO - TEST-OK | kraken | took 64235ms 03:17:17 INFO - SUITE-END | took 1187s 03:17:18 INFO - Completed test suite (00:19:47) 03:17:18 INFO - javascript benchmark 03:17:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2615.1239334822835, 2626.382800041991, 2650.2181856352368, 2673.0, 2682.5439675255207, 4652.883677908054, 4735.455422626399, 4778.068276686044, 4782.952170478298, 4787.2101103317955, 4742.217534106868, 4750.216214324632, 4759.190937540618, 4802.279658051294, 4847.491013443581, 4356.128774245148, 4380.802863871118, 4428.512863585003, 4440.356148358486, 4441.733495990251, 4402.07556413152, 4454.398656181406, 4455.034298192822, 4462.286034234523, 4484.394606728099, 4296.5273819879785, 4418.3372494125815, 4419.027813880941, 4431.889202769924, 4512.954870451286, 4342.652587793001, 4419.45881118355, 4420.513743488214, 4425.7565833879125, 4433.8448154314765, 4367.67242456817, 4380.9780951095045, 4389.934150987738, 4391.143726973241, 4394.868153955386, 4828.782704778258, 4860.1737704590305, 4882.804687812519, 4885.071836351082, 4905.533974272438, 5142.280080788692, 5154.229251369319, 5158.380994280673, 5158.638895277332, 5162.92255616166, 5182.585393168538, 5184.300119483859, 5185.507376799198, 5190.688558686491, 5250.9737451312885, 4656.580907718288, 4706.176419126639, 4709.858704238878, 4720.88197795051, 4772.308015337757, 5217.426083130853, 5227.738613069331, 5229.0, 5237.266782650432, 5271.762770675329, 4969.428515720666, 4997.575206107522, 5014.749262536931, 5016.322796422509, 5077.26379674945, 4855.077535268288, 4894.681845680019, 4901.926471102936, 5084.56781173597, 5095.770690318945, 5002.52476014778, 5026.321446604735, 5056.494350564988, 5121.052605268037, 5123.359580052494, 5044.218146187347, 5047.495250474996, 5048.066107770074, 5054.039732450822, 5093.8726531836255, 4241.703080784316, 4242.851500197478, 4251.149770046003, 4287.464066991626, 4298.376735373354, 3634.2913131939017, 3649.033006253345, 3684.1710615111388, 3689.594144644087, 3699.056740531147, 4356.825726970949, 4360.607545320873, 4363.541828108003, 4406.096750166208, 4413.977930110329, 5000.324956130876, 5046.697198168122, 5048.495150484996, 5058.215976523645, 5101.260317254051, 4281.357796330575, 4291.0, 4353.804078816461, 4354.216241076637, 4402.581754733295, 4492.438445194351, 4499.0776890737325, 4513.480949690827, 4520.028193938319, 4566.70316429431, 4796.8081276748535, 4797.088553174885, 4798.304245884327, 4801.639877009308, 4866.853994380174, 5090.160123579568, 5093.032323858455, 5098.260752190986, 5101.51535604117, 5157.742112894265, 4656.906861862812, 4717.457492388282, 4721.197396442544, 4818.494058123846, 4874.756262186947, 5113.92329115071, 5115.386153661584, 5118.436971933159, 5171.482851714949, 5181.222816577543, 5148.536631703165, 5183.533481986639, 5194.740262986911, 5197.7661005254095, 5261.237120617566, 4750.239961606127, 4801.279808028684, 4810.975945120252, 4998.775055122455, 5011.248312753116, 5022.422421421583, 5041.420236672683, 5060.987802439453, 5063.8480845574695, 5120.487951204998, 4930.063287975273, 4963.329950456642, 4970.3290055842, 4972.477889821516, 5037.798488060436, 4885.022995400863, 4945.752712364296, 5081.136206844772, 5098.872528186825, 5101.591872650253, 4878.146324393146, 4882.0, 4923.950760492493, 4927.310176575211, 4940.135476291706], "value": 4681.88322651213, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.927339445872, 563.2199403825701, 568.6701713006454, 578.5660754434174, 583.4020129367401, 27924.0, 37992.0, 39289.80355098227, 39325.410118848165, 42782.358264625975, 39253.41119883197, 39674.40488392669, 39712.0, 39733.40399894004, 39757.60242397575, 7589.051368578914, 7665.923340766577, 7680.500767450126, 7684.577348245844, 7684.9615751921165, 7575.696972121109, 7655.119661238945, 7659.961700191491, 7663.540187588735, 7664.348530374925, 7653.272939070779, 7705.499142555744, 7727.768166955, 7729.7681069567725, 7735.574543400111, 7676.961615191916, 7731.072271327421, 7732.072151341818, 7744.225577442267, 7746.9225307746765, 7600.2779735925, 7605.619719014027, 7670.041244844395, 7672.194419585975, 7681.615919204018, 36976.81511592425, 37142.8142859284, 37203.62796372029, 37237.441438378446, 37782.24435511302, 2894.13176047185, 2993.5125578700786, 3013.560523255523, 3050.496668049769, 3168.3504881499466, 27550.311242219104, 28253.858730706215, 28362.0, 28636.570451443244, 29371.265718356997, 3370.4438767603315, 3487.808170550619, 3505.071156143624, 3515.244222492151, 3580.534530511043, 225777.0, 226552.0, 227206.0, 228790.99999999834, 229003.0, 30126.397472050438, 49795.751021245385, 50257.70747826568, 50285.497145028814, 50324.49675503271, 30373.24066898301, 32525.837370813468, 32612.67387326144, 32633.0, 32642.347153056806, 13140.0, 13253.73492530144, 13260.204387736767, 13265.80101298462, 13269.867301327056, 10965.177611679155, 11049.613263535899, 11065.170112241614, 11080.833787493195, 11090.168237382228, 7595.5822429766895, 7658.157602663702, 7676.846463070708, 7682.1549629540705, 7722.304992550585, 2996.7752418568257, 3019.637643482752, 3057.617797775278, 3063.417950589381, 3064.249258931576, 881.6032785246665, 881.6870011146079, 927.9443233406017, 980.7253968888723, 981.9852702209473, 26775.732242677714, 26881.731182688312, 27084.86457567739, 27846.443071138463, 27905.441891162063, 939.5208443693765, 947.5972711597543, 950.9144177024101, 961.2022021721954, 995.4674249276748, 13403.195808251536, 14239.715205695828, 14429.567112986628, 14444.927775361057, 14653.0, 350308.0, 354259.0, 356238.0, 356450.0, 356492.0, 46369.30446043312, 46717.299240510736, 46906.29640555394, 46921.0, 46948.0, 1056.1339701444895, 1080.330195278932, 1125.763589646167, 1162.651204638622, 1174.2581073194187, 26626.334341641614, 28275.858620707586, 29060.12819615415, 29211.7078829209, 29266.561001585418, 39954.60045399509, 40341.59658403378, 40354.0, 40415.0, 40424.0, 276368.0, 277452.0, 277531.0, 278399.0, 278533.0, 23478.882605586863, 24282.757172428755, 24358.75641243565, 24380.6342904853, 24506.754932450447, 39710.20579588334, 39860.80069599633, 40049.0, 40495.392569112075, 40848.0, 34352.141196470286, 34480.0, 34896.65103348934, 34948.0, 35024.64975350214, 33294.0, 33434.66565334315, 33481.83259083689, 33818.49272260967, 33829.154271143416, 29598.852005739835, 29949.550756739103, 34592.308153837286, 34642.82678586591, 34765.65234347624, 28555.571666424607, 31214.2073231571, 35061.649383505835, 35497.64502355047, 35525.82237088798, 24689.62965555482, 24827.255182344557, 24923.0, 24996.0, 25253.24240272795], "value": 15915.820456369858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.7102546936981, 364.63354328899453, 366.7671028896651, 380.106749139522, 383.31960769633895, 15630.140342281184, 16652.750208746864, 17501.649967000652, 17585.120743962816, 17588.912055439705, 16166.272517736701, 16223.675526489464, 17127.74308385375, 17225.0, 17273.91363043183, 4860.829870954526, 5081.491850814908, 5105.310783044297, 5112.923306150411, 5123.743812809364, 3702.3705969985167, 3906.570277269512, 5013.849584512453, 5693.886122277552, 5985.730642121115, 6058.030715085587, 6064.575479716422, 6065.666388348639, 6066.211392518966, 6069.848253793669, 5829.154772557977, 5998.1602575639445, 5999.490043346299, 6011.0, 6021.759129634787, 4555.794989225493, 5284.947150528523, 5287.920681189786, 5293.576513878919, 5294.655847369909, 11829.0, 12161.479815023122, 12175.573854915036, 12176.452059657337, 12179.451924663412, 1842.0513435580688, 1850.6206227723285, 1966.9409917702492, 2044.7750747417772, 2270.2167752125492, 8821.558922053871, 8843.60203790831, 9018.503982280972, 9140.223081038053, 9271.304652151048, 1625.7805196298466, 1711.7860267466567, 1719.6216832296875, 1738.3481194552044, 1738.7478815571671, 59791.0, 60261.69869150626, 61509.384906150815, 63338.54913939241, 63609.36390636127, 9614.71155865325, 9659.227261819178, 9850.50747462624, 9962.750931226632, 10026.899731002743, 13258.73482530344, 13277.93361033208, 13298.0, 13314.201147931155, 13315.201087934754, 6744.426723728538, 6796.728130874809, 6991.196012458632, 7120.145582530129, 7225.747098851515, 6353.5386861022225, 6441.227052753606, 6499.772507962293, 6518.44593209573, 6801.1158549388265, 4147.336426171798, 4209.894752631209, 4226.17589570037, 4339.956600434019, 4356.390105385249, 1517.9165145917082, 1630.5434478346083, 1742.5120966129505, 1773.5743421578727, 1853.8053504382115, 705.9152901651732, 803.1326167738945, 824.2169938558394, 835.6573804740027, 845.306848384319, 14918.0, 15351.462698805712, 15479.613009674624, 15549.144797036271, 16409.343626254817, 777.0531448847287, 791.1376599506566, 801.8396320735759, 803.1446509467398, 819.8647223208224, 8512.787180320418, 8719.0, 9032.548372581345, 9045.366824322366, 9204.815903682023, 331000.0, 345889.0, 348253.0, 349088.0, 349744.0, 65820.0, 65868.0, 68076.31923680799, 68144.0, 68826.65586672035, 851.7870532366908, 861.5476874640864, 866.9263112635497, 868.2012548455436, 879.5734068976541, 13637.590872273848, 13781.862181378057, 13800.309984500534, 13813.102148360324, 14466.20435876037, 33231.66768332382, 33710.662893370754, 33929.321413571095, 34117.658823411446, 34824.47763283502, 43836.561634384525, 44116.33825492556, 44475.0, 46412.0, 46707.76646116884, 6847.315268473113, 7024.329134312275, 7059.788206353817, 7438.62806859644, 7526.887096693664, 8240.629171687408, 9797.461139637388, 9881.50592470388, 9995.800083998425, 10646.627368042082, 8490.702825401082, 8509.87235191485, 8549.487030778173, 8771.912280877365, 8856.247218986458, 9394.67118650844, 9547.761305967406, 9728.686627305224, 9737.561809718722, 10018.248631352824, 8926.642934282556, 9068.546572671208, 9122.133397327243, 9295.25637948976, 9516.286278529, 7008.614526200904, 7019.508634395544, 7033.753818616324, 7123.679434425359, 7211.747588834365, 8468.703595374132, 8519.531425771642, 8640.956795216236, 8777.561121944005, 9052.90947090547], "value": 7634.5815503721715, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1312.6980794417282, 1381.5371850430106, 1420.85081066488, 1678.7985441746978, 1697.1683874901294, 6418.133551970483, 6648.634325112117, 7328.706851725925, 7890.329322007629, 7902.565358905265, 7373.557586544811, 7636.885446718304, 7636.892650565665, 7787.260210280015, 7824.374050075994, 2083.593699228651, 2115.3971118231307, 2123.62836503612, 2125.234915430444, 2125.256160343875, 1795.6139430022542, 1853.0456814740419, 2075.647139986206, 2119.3218170185546, 2158.125958986613, 1842.1802297977406, 1866.094943952189, 1868.2900497810813, 2047.948801279965, 2112.419084751698, 2014.5064459207515, 2015.042854644047, 2016.2539860251654, 2028.3103744726864, 2028.8782673039666, 1997.1412292714126, 1997.5205950571903, 2005.6089062632793, 2033.8779673219653, 2034.8575599708026, 7880.014998125234, 7908.80227994299, 7927.5243485391065, 7942.285194332538, 7973.122956474783, 4418.851098714325, 4473.9105217895785, 4528.864134075983, 4537.478190008158, 4541.45502539694, 2793.539066054099, 2881.812682175652, 2883.6972117927735, 2914.5191043477803, 2944.5877577139217, 894.3873446689039, 931.4318265857821, 935.2237642756496, 949.8290307744603, 952.6998995316453, 10568.788624227473, 10618.309809862334, 10619.681409557648, 10636.414997175152, 10644.946775266151, 3957.1689945111275, 3979.721419500665, 4101.774402407897, 4213.157368526307, 4231.2172248133575, 8969.730908072768, 8987.730368088967, 8995.145461181177, 9000.459972401677, 9003.639854405881, 4575.176468235683, 4603.49361570227, 4607.792649330788, 4612.815487380534, 4613.308003799457, 4140.772257525805, 4228.788560571959, 4230.471191101113, 4230.598093181205, 4232.343986682069, 3583.211693427442, 3623.474596183539, 3682.5949145593963, 3696.149885526344, 3710.962890371062, 1118.552578968419, 1173.7769823733463, 1179.9351035693119, 1180.7461395799944, 1186.9703257418635, 778.8014056415577, 799.580220384303, 801.2628381888676, 809.8704207326799, 823.2097186700714, 4627.768611569408, 4647.814087436464, 4753.619710423158, 4756.904861902743, 4947.529984651453, 377.6167190301846, 388.07637821983496, 394.07589203318173, 399.3650096346764, 401.6164562842537, 3232.725218356419, 3429.6913277805115, 3746.38184699527, 3870.748401353903, 3883.5339759229073, 9272.953635231916, 9459.621615135455, 9487.573059212353, 9565.378250413702, 9569.186619137452, 9454.810903782023, 9470.384425012353, 9473.810523789623, 9484.525773711286, 9484.762880928032, 6849.109615750021, 7167.139943206848, 7345.669444874993, 7346.706131754777, 7350.117985841626, 5502.202180683698, 5505.972470137784, 5631.521320687623, 5706.28671416073, 5867.794627188028, 8435.186434916523, 8567.357448191286, 8750.431221970552, 8758.956205218934, 8780.341474389319, 8807.427517211361, 8897.065808090058, 9022.593983270637, 9063.184313411824, 9078.54607269647, 6228.065790131516, 6370.713317900798, 6404.1674582304, 6528.804135875931, 6664.033715111184, 7169.928300717134, 7220.494565380373, 7221.205667376479, 7228.385587225145, 7234.5659260444545, 6416.230052393743, 6464.5151613630105, 6501.544891857714, 6504.902426463512, 6634.83412914681, 6383.0744542042075, 6391.776287829904, 6451.032345148265, 6475.093486911742, 6613.14029176204, 5982.4316689914385, 6067.029275315928, 6071.119687645355, 6073.635581865102, 6077.908831367621, 4080.6327430531396, 4127.174565086934, 4137.40007698888, 4257.297545904891, 4309.719868208556, 4016.638502534786, 4017.0, 4024.7786371749835, 4146.129312844216, 4208.074223670787], "value": 3938.3395401126154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.49218929359273, 297.29540987858775, 300.5701846359705, 300.706810859412, 303.6508015781852, 4733.408323959505, 4833.250846118857, 4893.241547560129, 4897.706137631744, 4909.852704418869, 4740.791098269945, 4795.496472870351, 4799.376081109451, 4808.663393562452, 4819.662623616348, 3543.6456354364614, 3666.7066634669295, 3674.4488326751066, 3777.490038844748, 3789.147441825595, 3757.2861156380336, 3764.1530655602405, 3765.548134223883, 3777.7922214278206, 3790.9810450947843, 3719.79541125238, 3727.5526936767624, 3731.2350968051483, 3731.9067023324496, 3732.581618984782, 3538.964610353915, 3614.5662520497444, 3639.29033838399, 3742.419924911643, 3755.192633583779, 3259.4784834426378, 3259.6740325967453, 3263.233140212048, 3272.885449009297, 3280.5407242986003, 4638.837640682594, 4675.625949923998, 4683.899283668336, 4696.835610753641, 4698.801805539566, 4161.25097482456, 4262.87211383659, 4266.786660666985, 4268.59448352406, 4270.12462445198, 4957.107720610289, 4974.452810190876, 4975.7263350515705, 4991.425986011583, 4994.725290109042, 3545.592256890465, 3547.343741407848, 3552.2540266544056, 3553.289342131558, 3555.928881422357, 5224.660397074178, 5227.47725227478, 5232.372115346183, 5243.404514765216, 5244.60665450089, 3452.533907922398, 3618.3125206210734, 3624.3657359961903, 3648.416253399443, 3650.9634903651154, 3687.94468082979, 3691.206390626028, 3691.630836916287, 3698.6671199592165, 3706.4625629283605, 4202.579742025773, 4218.261804184317, 4224.0, 4246.596573325529, 4247.256730072287, 4878.95121048792, 4950.612994490538, 4991.850244492671, 5036.169032109661, 5049.697018178921, 1210.5581462766027, 1235.5057976809348, 1240.6030070377574, 1241.7392347607104, 1242.6147894152841, 803.1091940615534, 805.472415567804, 826.8259072117608, 828.9212524810254, 834.5701963488808, 4005.218982298482, 4012.7191096622955, 4266.168097221074, 4384.758838263926, 4399.626031787334, 5010.549050585465, 5036.179739345905, 5046.823361182341, 5058.140116180258, 5083.822066227738, 4479.507254202035, 4484.910301793946, 4488.438945131858, 4490.438695163105, 4514.367988481549, 2618.4763047390597, 2727.4726153354186, 2732.8496932668895, 2750.752432281104, 2751.7110703376256, 4890.462049174588, 4890.82882099132, 4890.926636100461, 4894.388201474816, 4901.5343542364135, 5288.0, 5290.65610735301, 5293.814716484904, 5300.231466437422, 5306.681599103988, 4735.147673418749, 4791.976040119777, 4805.8558243252755, 4859.975700121477, 4909.239067944474, 5084.618653601069, 5094.420729573844, 5135.3324067870935, 5160.716160611202, 5173.689578625294, 4986.501349864984, 5026.547610715053, 5059.5952323814745, 5110.66780659256, 5116.565091967224, 4757.809687612456, 4802.455688682076, 4892.535209155125, 4907.975460122677, 4931.3589233399425, 3579.9463008055423, 3633.000924745716, 3634.0, 3637.7445983490406, 3642.927141457103, 5103.413107492686, 5128.3076784633595, 5138.922916156186, 5171.793128274827, 5176.275321454924, 4800.0, 4919.44103163423, 4924.8276310328965, 4953.628477864103, 4963.7911129547, 4939.580135688507, 4942.7034377936, 4982.427020892644, 5013.824516141917, 5022.522860328263, 4933.741895816544, 4942.57988071018, 4955.8017679292425, 4959.776810043484, 4967.528084831935, 4813.278008298783, 4819.2530157825595, 5044.4198917125, 5054.78685115577, 5087.872803179802, 4792.376990991149, 4865.756712164307, 4941.728204948762, 4944.258361245842, 4952.579030782424], "value": 3758.3805379055566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.8832865919803, 720.7117153138744, 733.512214377439, 739.2792027772919, 760.1831622422411, 12567.434465449054, 13549.593512194637, 13568.592942211724, 13573.253471059088, 13593.048486605941, 12743.936280318609, 13186.604401867959, 13214.0, 13460.394282257297, 13465.394057267422, 783.6160281462099, 806.1454857850697, 807.858624740671, 807.9555624440653, 808.4381354958306, 618.9350118237588, 631.409631994087, 765.7396485195032, 796.3549524884833, 798.2336956521746, 825.9215374539409, 829.0258945738763, 829.0424559633633, 835.807764214231, 835.8286551257008, 823.2672921100195, 826.3760860550276, 827.3422629009951, 828.0601517277872, 828.4656396624143, 473.19084365734636, 476.28794951547656, 590.9586328956975, 612.5405945540845, 612.8100288910407, 12585.056120790978, 13045.478180872753, 13164.736705265937, 13217.603471895858, 13277.668058298523, 11979.520819167223, 12136.15046946714, 12362.0, 12666.0, 12725.872741272562, 11570.768584628344, 11620.709482263012, 11654.592089276919, 11730.296182229093, 11742.823857642143, 4025.75845449274, 4056.858009969637, 4059.0664147246002, 4093.1199792044554, 4139.5653456387245, 60414.39585604176, 61033.694831526445, 61169.0, 61389.07916381258, 61797.6910115451, 9704.805903881883, 9805.313628046111, 10057.497125143713, 10513.737156571147, 10562.471876406149, 17797.822021779877, 17877.37429189972, 17904.0, 17904.641907161782, 17981.1009449527, 6399.8080057598345, 6622.96688516564, 6677.899831502531, 6726.125603671491, 6937.583744975318, 3170.2391426058043, 3404.863805447754, 3600.3519366513756, 3603.891883243507, 3613.602503724588, 2725.8909643614033, 2849.187981425284, 2861.2703760541344, 3170.651228364878, 3317.3531161423775, 553.4354957942876, 558.7485631465856, 569.4931510955253, 577.096843440015, 584.1442287049408, 505.75723652646934, 606.7027156693189, 613.1416017575341, 621.586644881149, 623.4700504571078, 7878.172791856887, 7894.486858354188, 8493.278071364004, 8710.825783484295, 8733.956330218309, 459.7264627546671, 512.8000079968815, 546.7840203119746, 599.4544964082664, 600.1927407636722, 3835.7907714333696, 3980.3432433648704, 4097.610726980932, 4102.630763231324, 4190.476190476191, 73484.63257683677, 87849.56075219583, 100443.49778251062, 100978.0, 101662.49168754109, 48160.27759583609, 48935.26597101046, 49019.26471102936, 53929.1910621341, 83256.58371708103, 56227.71886140543, 73997.0, 75830.0, 76103.0, 77207.61396192871, 7476.140243871807, 7482.326590606872, 7489.588072656056, 7550.018497595277, 7793.766187014398, 45170.32244516269, 45694.771526142154, 46939.295910560686, 47526.52473475221, 47926.760366197945, 59746.0, 63997.68001160151, 64569.35430645821, 65027.34972650213, 67972.660136699, 9353.579088941151, 9373.343865929592, 9377.390469619453, 9566.378185417925, 9817.116459518393, 10864.185186111232, 12139.332336721565, 12337.876621234032, 12362.44369003415, 13602.183868967893, 11949.283043017447, 12207.206531575419, 12382.257064576153, 12484.750304994031, 12884.291363975071, 10583.4708264588, 11034.0, 11253.831192531954, 11953.462094205608, 12356.443960021641, 11209.0, 11621.477033533341, 11693.415329233674, 11753.647390578297, 12348.567800126952, 9241.445513269226, 9335.299852510952, 9996.450195239331, 10054.447005414773, 10146.188304935735, 9685.601894513818, 10096.725857116451, 10124.387035043877, 10128.572565878467, 10165.898341016495], "value": 6482.75615636477, "unit": "score"}], "name": "dromaeo_css", "value": 6159.221911302257, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 112.0, 114.0, 113.0, 114.0, 112.0, 114.0, 112.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 127.0, 129.0, 166.0, 134.0, 134.0, 135.0, 128.0, 159.0, 128.0], "value": 138.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 163.0, 161.0, 166.0, 161.0, 162.0, 160.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 112.0, 78.0, 79.0, 76.0, 76.0, 107.0, 76.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 130.0, 84.0, 83.0, 83.0, 108.0, 83.0, 83.0, 113.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 147.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 62.0, 64.0, 63.0, 62.0, 63.0, 63.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 68.0], "value": 66.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 83.0, 93.0, 88.0, 90.0, 83.0, 84.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 143.0, 150.0, 146.0, 141.0, 156.0, 137.0, 184.0, 147.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 179.0, 176.0, 183.0, 181.0, 185.0, 179.0, 173.0, 177.0], "value": 179.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 69.0, 70.0, 72.0, 70.0, 69.0, 72.0, 70.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1552.6999999999998, "alertThreshold": 2.0}]} 03:17:18 INFO - Return code: 0 03:17:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:17:18 INFO - # TBPL SUCCESS # 03:17:18 INFO - Running post-action listener: _resource_record_post_action 03:17:18 INFO - [mozharness: 2016-10-25 10:17:18.503021Z] Finished run-tests step (success) 03:17:18 INFO - Running post-run listener: _resource_record_post_run 03:17:18 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391426048; Read time: 20; Write time: 346616 03:17:18 INFO - TinderboxPrint: CPU usage
13.0% 03:17:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 03:17:18 INFO - TinderboxPrint: I/O write bytes / time
391,426,048 / 346,616 03:17:18 INFO - TinderboxPrint: CPU idle
8,353.0 (86.9%) 03:17:18 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 03:17:18 INFO - TinderboxPrint: Swap in / out
0 / 0 03:17:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99139584; Read time: 0; Write time: 106704 03:17:18 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 291880960; Read time: 0; Write time: 239884 03:17:19 INFO - Running post-run listener: _upload_blobber_files 03:17:19 INFO - Blob upload gear active. 03:17:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:17:19 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 03:17:19 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'] 03:17:19 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 03:17:19 INFO - (blobuploader) - INFO - Open directory for files ... 03:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:24 INFO - (blobuploader) - INFO - Done attempting. 03:17:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:17:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:17:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:25 INFO - (blobuploader) - INFO - Done attempting. 03:17:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:17:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:17:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:17:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:17:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:17:26 INFO - (blobuploader) - INFO - Done attempting. 03:17:26 INFO - (blobuploader) - INFO - Iteration through files over. 03:17:26 INFO - Return code: 0 03:17:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:17:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:17:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46509bc669f315e968587f05b2d41514325d3e8d78db810bc17391bd1cf6e1609c943b5664aab622b390bc17545e889f48eeb0acbf52f8f897883baa1474fcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f732db7913016a19979dbec893bcbcefd876bb9767fda9e0e506e8059d9983fe5a204e4ede918b9f8a1b6f1c8e60478721c377a6e7601a7a9df43ee848c111cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dbf0e036b4733cc9b1e785485bec803fda5dbe789f893ce9404cd9b2da28eb617caaa9670e459dd323378b7a3180e0bec13ec034c1deaad42840dbe19caf9c7"} 03:17:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:17:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:17:26 INFO - Contents: 03:17:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46509bc669f315e968587f05b2d41514325d3e8d78db810bc17391bd1cf6e1609c943b5664aab622b390bc17545e889f48eeb0acbf52f8f897883baa1474fcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f732db7913016a19979dbec893bcbcefd876bb9767fda9e0e506e8059d9983fe5a204e4ede918b9f8a1b6f1c8e60478721c377a6e7601a7a9df43ee848c111cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dbf0e036b4733cc9b1e785485bec803fda5dbe789f893ce9404cd9b2da28eb617caaa9670e459dd323378b7a3180e0bec13ec034c1deaad42840dbe19caf9c7"} 03:17:26 INFO - Running post-run listener: copy_logs_to_upload_dir 03:17:26 INFO - Copying logs to upload dir... 03:17:26 INFO - mkdir: /builds/slave/test/build/upload/logs 03:17:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.970547 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-10-25 03:17:25.665734) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:17:25.671960) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340 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/46509bc669f315e968587f05b2d41514325d3e8d78db810bc17391bd1cf6e1609c943b5664aab622b390bc17545e889f48eeb0acbf52f8f897883baa1474fcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f732db7913016a19979dbec893bcbcefd876bb9767fda9e0e506e8059d9983fe5a204e4ede918b9f8a1b6f1c8e60478721c377a6e7601a7a9df43ee848c111cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dbf0e036b4733cc9b1e785485bec803fda5dbe789f893ce9404cd9b2da28eb617caaa9670e459dd323378b7a3180e0bec13ec034c1deaad42840dbe19caf9c7"} build_url:https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011373 build_url: 'https://queue.taskcluster.net/v1/task/Fw7otkmzS8aPrerBn7S0dw/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/46509bc669f315e968587f05b2d41514325d3e8d78db810bc17391bd1cf6e1609c943b5664aab622b390bc17545e889f48eeb0acbf52f8f897883baa1474fcf4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f732db7913016a19979dbec893bcbcefd876bb9767fda9e0e506e8059d9983fe5a204e4ede918b9f8a1b6f1c8e60478721c377a6e7601a7a9df43ee848c111cc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6dbf0e036b4733cc9b1e785485bec803fda5dbe789f893ce9404cd9b2da28eb617caaa9670e459dd323378b7a3180e0bec13ec034c1deaad42840dbe19caf9c7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 03:17:25.697561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:17:25.697915) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1477383810.978397-283842340 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 03:17:25.785033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:17:25.785388) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 03:17:25.785726) ========= ========= Total master_lag: 0.17 =========