builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-004 starttime: 1479473775.33 results: success (0) buildid: 20161118021428 builduid: db273267aa5c47ee9bbf26bf7c372bc2 revision: 594e6d7a00aff726c2284e8a40bd0b03d63c7187 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.331962) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.332467) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.332809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.385358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.385664) ========= 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=c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 04: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2016-11-18 04:56:15 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.071714 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.473311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.473640) ========= 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=c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016212 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.524505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:15.524857) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 594e6d7a00aff726c2284e8a40bd0b03d63c7187 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 594e6d7a00aff726c2284e8a40bd0b03d63c7187 --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=c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 04:56:16,011 truncating revision to first 12 chars 2016-11-18 04:56:16,011 Setting DEBUG logging. 2016-11-18 04:56:16,011 attempt 1/10 2016-11-18 04:56:16,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/594e6d7a00af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 04:56:16,312 unpacking tar archive at: mozilla-aurora-594e6d7a00af/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:16.194016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:16.194346) ========= script_repo_revision: 594e6d7a00aff726c2284e8a40bd0b03d63c7187 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:16.194771) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:16.195104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 04:56:16.205723) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-18 04:56:16.206031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:56:16 INFO - MultiFileLogger online at 20161118 04:56:16 in /builds/slave/test 04:56:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:56:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:16 INFO - {'append_to_log': False, 04:56:16 INFO - 'base_work_dir': '/builds/slave/test', 04:56:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:56:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:16 INFO - 'branch': 'Mozilla-Aurora', 04:56:16 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:16 INFO - 'config_files': ('talos/linux_config.py',), 04:56:16 INFO - 'default_actions': ('clobber', 04:56:16 INFO - 'read-buildbot-config', 04:56:16 INFO - 'download-and-extract', 04:56:16 INFO - 'populate-webroot', 04:56:16 INFO - 'create-virtualenv', 04:56:16 INFO - 'install', 04:56:16 INFO - 'run-tests'), 04:56:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:16 INFO - 'download_minidump_stackwalk': True, 04:56:16 INFO - 'download_symbols': 'ondemand', 04:56:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:16 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:16 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:16 INFO - 'installer_path': 'installer.exe', 04:56:16 INFO - 'log_level': 'info', 04:56:16 INFO - 'log_name': 'talos', 04:56:16 INFO - 'log_to_console': True, 04:56:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:56:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:56:16 INFO - 'opt_config_files': (), 04:56:16 INFO - 'pip_index': False, 04:56:16 INFO - 'sps_profile': False, 04:56:16 INFO - 'sps_profile_interval': 0, 04:56:16 INFO - 'suite': 'dromaeojs-e10s', 04:56:16 INFO - 'system_bits': '32', 04:56:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:16 INFO - 'title': 'talos-linux64-ix-004', 04:56:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:16 INFO - 'use_talos_json': True, 04:56:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:16 INFO - 'work_dir': 'build'} 04:56:16 INFO - [mozharness: 2016-11-18 12:56:16.782953Z] Running clobber step. 04:56:16 INFO - Running pre-action listener: _resource_record_pre_action 04:56:16 INFO - Running main action method: clobber 04:56:16 INFO - rmtree: /builds/slave/test/build 04:56:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:17 INFO - Running post-action listener: _resource_record_post_action 04:56:17 INFO - [mozharness: 2016-11-18 12:56:17.752316Z] Finished clobber step (success) 04:56:17 INFO - [mozharness: 2016-11-18 12:56:17.752414Z] Running read-buildbot-config step. 04:56:17 INFO - Running pre-action listener: _resource_record_pre_action 04:56:17 INFO - Running main action method: read_buildbot_config 04:56:17 INFO - Using buildbot properties: 04:56:17 INFO - { 04:56:17 INFO - "project": "", 04:56:17 INFO - "product": "firefox", 04:56:17 INFO - "script_repo_revision": "production", 04:56:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:56:17 INFO - "repository": "", 04:56:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 04:56:17 INFO - "buildid": "20161118021428", 04:56:17 INFO - "pgo_build": "True", 04:56:17 INFO - "basedir": "/builds/slave/test", 04:56:17 INFO - "buildnumber": 653, 04:56:17 INFO - "slavename": "talos-linux64-ix-004", 04:56:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:56:17 INFO - "platform": "ubuntu64_hw", 04:56:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 04:56:17 INFO - "branch": "mozilla-aurora", 04:56:17 INFO - "repo_path": "releases/mozilla-aurora", 04:56:17 INFO - "revision": "594e6d7a00aff726c2284e8a40bd0b03d63c7187", 04:56:17 INFO - "stage_platform": "linux64-pgo", 04:56:17 INFO - "builduid": "db273267aa5c47ee9bbf26bf7c372bc2", 04:56:17 INFO - "slavebuilddir": "test" 04:56:17 INFO - } 04:56:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 04:56:17 INFO - Running post-action listener: _resource_record_post_action 04:56:17 INFO - [mozharness: 2016-11-18 12:56:17.755131Z] Finished read-buildbot-config step (success) 04:56:17 INFO - [mozharness: 2016-11-18 12:56:17.755217Z] Running download-and-extract step. 04:56:17 INFO - Running pre-action listener: _resource_record_pre_action 04:56:17 INFO - Running main action method: download_and_extract 04:56:17 INFO - mkdir: /builds/slave/test/build/tests 04:56:17 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')]} 04:56:17 INFO - trying https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:56:17 INFO - Downloading https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:56:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:56:18 INFO - Downloaded 1361 bytes. 04:56:18 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 04:56:18 INFO - Using the following test package requirements: 04:56:18 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:56:18 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 04:56:18 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 04:56:18 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'jsshell-linux-x86_64.zip'], 04:56:18 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 04:56:18 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 04:56:18 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 04:56:18 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 04:56:18 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 04:56:18 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 04:56:18 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 04:56:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:56:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:56:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:56:18 INFO - Fetch https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:56:18 INFO - Http code: 200 04:56:18 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 04:56:18 INFO - x-amz-cf-id: 47TUsa_k7oqSMWdnXKS8sKorLt5ag2aISH0qkX_LTsJ_8xmQ0HwBZg== 04:56:18 INFO - x-amz-version-id: 25og0Id28GDckacmk6YH.T4BvmC0HhFk 04:56:20 INFO - Expected file size: 21947271 04:56:20 INFO - Obtained file size: 21947271 04:56:24 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:56:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 04:56:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:56:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 04:56:24 INFO - Http code: 200 04:56:24 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 04:56:24 INFO - x-amz-cf-id: WKITrzL6Cxet1egCpQ5-oVnKIy2twXnzz4eXYd_KKPflyhGvDM_1sQ== 04:56:24 INFO - x-amz-version-id: 25og0Id28GDckacmk6YH.T4BvmC0HhFk 04:56:25 INFO - Expected file size: 21947271 04:56:25 INFO - Obtained file size: 21947271 04:56:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 04:56:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:56:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 04:56:30 INFO - Http code: 200 04:56:30 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 04:56:30 INFO - x-amz-cf-id: HipVHmqDEuzmDsOsE_9hjn55ug0_vAHkTUuEQ8pbuaqvbfcTEb8MhA== 04:56:30 INFO - x-amz-version-id: IIXAALtzMY2b7XfETSXDqppSvWPwxqz1 04:56:31 INFO - Expected file size: 14409038 04:56:31 INFO - Obtained file size: 14409038 04:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:31 INFO - trying https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:56:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:56:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:56:32 INFO - Downloaded 63946468 bytes. 04:56:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:56:32 INFO - mkdir: /builds/slave/test/properties 04:56:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:56:32 INFO - Writing to file /builds/slave/test/properties/build_url 04:56:32 INFO - Contents: 04:56:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 04:56:33 INFO - Running post-action listener: _resource_record_post_action 04:56:33 INFO - Running post-action listener: set_extra_try_arguments 04:56:33 INFO - [mozharness: 2016-11-18 12:56:33.709980Z] Finished download-and-extract step (success) 04:56:33 INFO - [mozharness: 2016-11-18 12:56:33.710206Z] Running populate-webroot step. 04:56:33 INFO - Running pre-action listener: _resource_record_pre_action 04:56:33 INFO - Running main action method: populate_webroot 04:56:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:56:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:56:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:56:33 INFO - '--tppagecycles', 04:56:33 INFO - '7'], 04:56:33 INFO - 'tests': ['tsvgm']}}, 04:56:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:56:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:56:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:56:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:56:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:56:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['damp', 'tps']}, 04:56:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'tests': ['damp', 'tps']}, 04:56:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['dromaeo_dom']}, 04:56:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:56:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['basic_compositor_video']}, 04:56:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:56:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['a11yr', 04:56:33 INFO - 'ts_paint', 04:56:33 INFO - 'tpaint', 04:56:33 INFO - 'sessionrestore', 04:56:33 INFO - 'sessionrestore_no_auto_restore', 04:56:33 INFO - 'tabpaint']}, 04:56:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:56:33 INFO - 'ts_paint', 04:56:33 INFO - 'tpaint', 04:56:33 INFO - 'sessionrestore', 04:56:33 INFO - 'sessionrestore_no_auto_restore', 04:56:33 INFO - 'tabpaint']}, 04:56:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:56:33 INFO - 'ts_paint', 04:56:33 INFO - 'tpaint', 04:56:33 INFO - 'sessionrestore', 04:56:33 INFO - 'sessionrestore_no_auto_restore', 04:56:33 INFO - 'tabpaint']}, 04:56:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:56:33 INFO - 'ts_paint', 04:56:33 INFO - 'tpaint', 04:56:33 INFO - 'sessionrestore', 04:56:33 INFO - 'sessionrestore_no_auto_restore', 04:56:33 INFO - 'tabpaint']}, 04:56:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['a11yr', 04:56:33 INFO - 'ts_paint', 04:56:33 INFO - 'tpaint', 04:56:33 INFO - 'sessionrestore', 04:56:33 INFO - 'sessionrestore_no_auto_restore', 04:56:33 INFO - 'tabpaint']}, 04:56:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['a11yr', 04:56:33 INFO - 'ts_paint', 04:56:33 INFO - 'tpaint', 04:56:33 INFO - 'sessionrestore', 04:56:33 INFO - 'sessionrestore_no_auto_restore', 04:56:33 INFO - 'tabpaint']}, 04:56:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['tsvgx', 04:56:33 INFO - 'tsvgr_opacity', 04:56:33 INFO - 'tart', 04:56:33 INFO - 'tscrollx', 04:56:33 INFO - 'cart']}, 04:56:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:56:33 INFO - 'tsvgr_opacity', 04:56:33 INFO - 'tart', 04:56:33 INFO - 'tscrollx', 04:56:33 INFO - 'cart']}, 04:56:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'talos_options': ['--disable-e10s'], 04:56:33 INFO - 'tests': ['tp5o']}, 04:56:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'tests': ['tp5o']}, 04:56:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'talos_options': ['--disable-e10s', 04:56:33 INFO - '--xperf_path', 04:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:33 INFO - 'tests': ['tp5n']}, 04:56:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:56:33 INFO - 'talos_options': ['--xperf_path', 04:56:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:56:33 INFO - 'tests': ['tp5n']}}, 04:56:33 INFO - 'talos.zip': {'path': '', 04:56:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:56:33 INFO - Running post-action listener: _resource_record_post_action 04:56:33 INFO - [mozharness: 2016-11-18 12:56:33.730127Z] Finished populate-webroot step (success) 04:56:33 INFO - [mozharness: 2016-11-18 12:56:33.730215Z] Running create-virtualenv step. 04:56:33 INFO - Running pre-action listener: _resource_record_pre_action 04:56:33 INFO - Running main action method: create_virtualenv 04:56:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:56:33 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 04:56:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:56:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:56:33 INFO - Using real prefix '/usr' 04:56:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:56:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:56:36 INFO - Installing pip.................done. 04:56:36 INFO - Return code: 0 04:56:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:56:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:56:36 INFO - Reading from file tmpfile_stdout 04:56:36 INFO - Output received: 04:56:36 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) 04:56:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:56:36 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')]} 04:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:36 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')]} 04:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:36 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:36 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 04:56:36 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 04:56:36 INFO - Using env: {'DISPLAY': ':0', 04:56:36 INFO - 'HOME': '/home/cltbld', 04:56:36 INFO - 'LANG': 'en_US.UTF-8', 04:56:36 INFO - 'LANGUAGE': 'en_US:en', 04:56:36 INFO - 'LOGNAME': 'cltbld', 04:56:36 INFO - 'MAIL': '/var/mail/cltbld', 04:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:36 INFO - 'MOZ_NO_REMOTE': '1', 04:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:36 INFO - 'NO_EM_RESTART': '1', 04:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:36 INFO - 'PWD': '/builds/slave/test', 04:56:36 INFO - 'SHELL': '/bin/bash', 04:56:36 INFO - 'SHLVL': '1', 04:56:36 INFO - 'TERM': 'linux', 04:56:36 INFO - 'TMOUT': '86400', 04:56:36 INFO - 'USER': 'cltbld', 04:56:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:36 INFO - '_': '/tools/buildbot/bin/python'} 04:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:36 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 04:56:36 INFO - Cleaning up... 04:56:36 INFO - Return code: 0 04:56:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:56:36 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')]} 04:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:36 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')]} 04:56:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:36 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:36 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 04:56:36 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 04:56:36 INFO - Using env: {'DISPLAY': ':0', 04:56:36 INFO - 'HOME': '/home/cltbld', 04:56:36 INFO - 'LANG': 'en_US.UTF-8', 04:56:36 INFO - 'LANGUAGE': 'en_US:en', 04:56:36 INFO - 'LOGNAME': 'cltbld', 04:56:36 INFO - 'MAIL': '/var/mail/cltbld', 04:56:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:36 INFO - 'MOZ_NO_REMOTE': '1', 04:56:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:36 INFO - 'NO_EM_RESTART': '1', 04:56:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:36 INFO - 'PWD': '/builds/slave/test', 04:56:36 INFO - 'SHELL': '/bin/bash', 04:56:36 INFO - 'SHLVL': '1', 04:56:36 INFO - 'TERM': 'linux', 04:56:36 INFO - 'TMOUT': '86400', 04:56:36 INFO - 'USER': 'cltbld', 04:56:36 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:36 INFO - '_': '/tools/buildbot/bin/python'} 04:56:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:36 INFO - Downloading/unpacking psutil>=3.1.1 04:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:56:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:39 INFO - Installing collected packages: psutil 04:56:39 INFO - Running setup.py install for psutil 04:56:39 INFO - building 'psutil._psutil_linux' extension 04:56:39 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 04:56:39 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 04:56:39 INFO - building 'psutil._psutil_posix' extension 04:56:39 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 04:56:39 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 04:56:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:56:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:56:39 INFO - Successfully installed psutil 04:56:39 INFO - Cleaning up... 04:56:39 INFO - Return code: 0 04:56:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:56:39 INFO - Using env: {'DISPLAY': ':0', 04:56:39 INFO - 'HOME': '/home/cltbld', 04:56:39 INFO - 'LANG': 'en_US.UTF-8', 04:56:39 INFO - 'LANGUAGE': 'en_US:en', 04:56:39 INFO - 'LOGNAME': 'cltbld', 04:56:39 INFO - 'MAIL': '/var/mail/cltbld', 04:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:39 INFO - 'MOZ_NO_REMOTE': '1', 04:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:39 INFO - 'NO_EM_RESTART': '1', 04:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:39 INFO - 'PWD': '/builds/slave/test', 04:56:39 INFO - 'SHELL': '/bin/bash', 04:56:39 INFO - 'SHLVL': '1', 04:56:39 INFO - 'TERM': 'linux', 04:56:39 INFO - 'TMOUT': '86400', 04:56:39 INFO - 'USER': 'cltbld', 04:56:39 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:39 INFO - '_': '/tools/buildbot/bin/python'} 04:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:56:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:56:42 INFO - Installing collected packages: mozsystemmonitor 04:56:42 INFO - Running setup.py install for mozsystemmonitor 04:56:42 INFO - Successfully installed mozsystemmonitor 04:56:42 INFO - Cleaning up... 04:56:42 INFO - Return code: 0 04:56:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:56:42 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')]} 04:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:42 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')]} 04:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:42 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:42 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 04:56:42 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 04:56:42 INFO - Using env: {'DISPLAY': ':0', 04:56:42 INFO - 'HOME': '/home/cltbld', 04:56:42 INFO - 'LANG': 'en_US.UTF-8', 04:56:42 INFO - 'LANGUAGE': 'en_US:en', 04:56:42 INFO - 'LOGNAME': 'cltbld', 04:56:42 INFO - 'MAIL': '/var/mail/cltbld', 04:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:42 INFO - 'MOZ_NO_REMOTE': '1', 04:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:42 INFO - 'NO_EM_RESTART': '1', 04:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:42 INFO - 'PWD': '/builds/slave/test', 04:56:42 INFO - 'SHELL': '/bin/bash', 04:56:42 INFO - 'SHLVL': '1', 04:56:42 INFO - 'TERM': 'linux', 04:56:42 INFO - 'TMOUT': '86400', 04:56:42 INFO - 'USER': 'cltbld', 04:56:42 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:42 INFO - '_': '/tools/buildbot/bin/python'} 04:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:56:42 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 04:56:42 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 04:56:42 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 04:56:42 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 04:56:42 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 04:56:42 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 04:56:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:56:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:56:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:56:44 INFO - warning: no files found matching '*.txt' 04:56:44 INFO - no previously-included directories found matching 'build' 04:56:44 INFO - no previously-included directories found matching 'dist' 04:56:44 INFO - no previously-included directories found matching '.git*' 04:56:44 INFO - Installing collected packages: jsonschema, functools32 04:56:44 INFO - Running setup.py install for functools32 04:56:44 INFO - warning: no files found matching '*.txt' 04:56:44 INFO - no previously-included directories found matching 'build' 04:56:44 INFO - no previously-included directories found matching 'dist' 04:56:44 INFO - no previously-included directories found matching '.git*' 04:56:44 INFO - Successfully installed jsonschema functools32 04:56:44 INFO - Cleaning up... 04:56:45 INFO - Return code: 0 04:56:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:56:45 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')]} 04:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:45 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')]} 04:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:45 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:45 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 04:56:45 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 04:56:45 INFO - Using env: {'DISPLAY': ':0', 04:56:45 INFO - 'HOME': '/home/cltbld', 04:56:45 INFO - 'LANG': 'en_US.UTF-8', 04:56:45 INFO - 'LANGUAGE': 'en_US:en', 04:56:45 INFO - 'LOGNAME': 'cltbld', 04:56:45 INFO - 'MAIL': '/var/mail/cltbld', 04:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:45 INFO - 'MOZ_NO_REMOTE': '1', 04:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:45 INFO - 'NO_EM_RESTART': '1', 04:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:45 INFO - 'PWD': '/builds/slave/test', 04:56:45 INFO - 'SHELL': '/bin/bash', 04:56:45 INFO - 'SHLVL': '1', 04:56:45 INFO - 'TERM': 'linux', 04:56:45 INFO - 'TMOUT': '86400', 04:56:45 INFO - 'USER': 'cltbld', 04:56:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:45 INFO - '_': '/tools/buildbot/bin/python'} 04:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:56:45 INFO - Cleaning up... 04:56:45 INFO - Return code: 0 04:56:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:56:45 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')]} 04:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:45 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')]} 04:56:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:45 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:45 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 04:56:45 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 04:56:45 INFO - Using env: {'DISPLAY': ':0', 04:56:45 INFO - 'HOME': '/home/cltbld', 04:56:45 INFO - 'LANG': 'en_US.UTF-8', 04:56:45 INFO - 'LANGUAGE': 'en_US:en', 04:56:45 INFO - 'LOGNAME': 'cltbld', 04:56:45 INFO - 'MAIL': '/var/mail/cltbld', 04:56:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:45 INFO - 'MOZ_NO_REMOTE': '1', 04:56:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:45 INFO - 'NO_EM_RESTART': '1', 04:56:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:45 INFO - 'PWD': '/builds/slave/test', 04:56:45 INFO - 'SHELL': '/bin/bash', 04:56:45 INFO - 'SHLVL': '1', 04:56:45 INFO - 'TERM': 'linux', 04:56:45 INFO - 'TMOUT': '86400', 04:56:45 INFO - 'USER': 'cltbld', 04:56:45 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:45 INFO - '_': '/tools/buildbot/bin/python'} 04:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:45 INFO - Downloading/unpacking blobuploader==1.2.4 04:56:45 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 04:56:45 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 04:56:45 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 04:56:45 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 04:56:45 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 04:56:45 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 04:56:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:56:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04: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 04: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 04: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 04: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 04: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 04: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 04:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:56:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 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 04:56:48 INFO - Downloading docopt-0.6.1.tar.gz 04:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:56:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:56:48 INFO - Running setup.py install for blobuploader 04:56:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:56:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:56:48 INFO - Running setup.py install for requests 04:56:48 INFO - Running setup.py install for docopt 04:56:48 INFO - Successfully installed blobuploader requests docopt 04:56:48 INFO - Cleaning up... 04:56:48 INFO - Return code: 0 04:56:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:48 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:48 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 04:56:48 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 04:56:48 INFO - Using env: {'DISPLAY': ':0', 04:56:48 INFO - 'HOME': '/home/cltbld', 04:56:48 INFO - 'LANG': 'en_US.UTF-8', 04:56:48 INFO - 'LANGUAGE': 'en_US:en', 04:56:48 INFO - 'LOGNAME': 'cltbld', 04:56:48 INFO - 'MAIL': '/var/mail/cltbld', 04:56:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:48 INFO - 'MOZ_NO_REMOTE': '1', 04:56:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:48 INFO - 'NO_EM_RESTART': '1', 04:56:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:48 INFO - 'PWD': '/builds/slave/test', 04:56:48 INFO - 'SHELL': '/bin/bash', 04:56:48 INFO - 'SHLVL': '1', 04:56:48 INFO - 'TERM': 'linux', 04:56:48 INFO - 'TMOUT': '86400', 04:56:48 INFO - 'USER': 'cltbld', 04:56:48 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:48 INFO - '_': '/tools/buildbot/bin/python'} 04:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:49 INFO - Running setup.py (path:/tmp/pip-h4Jfd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:49 INFO - Running setup.py (path:/tmp/pip-8rGjGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:49 INFO - Running setup.py (path:/tmp/pip-r9yBSN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:49 INFO - Running setup.py (path:/tmp/pip-4bZVVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:49 INFO - Running setup.py (path:/tmp/pip-EAlfXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:49 INFO - Running setup.py (path:/tmp/pip-my4ArY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:49 INFO - Running setup.py (path:/tmp/pip-0h_dLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:49 INFO - Running setup.py (path:/tmp/pip-Wwi9kl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:49 INFO - Running setup.py (path:/tmp/pip-LjxJWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:49 INFO - Running setup.py (path:/tmp/pip-zXsAXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:49 INFO - Running setup.py (path:/tmp/pip-PXL_ed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:49 INFO - Running setup.py (path:/tmp/pip-OTMkk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:50 INFO - Running setup.py (path:/tmp/pip-rUvHiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:50 INFO - Running setup.py (path:/tmp/pip-VEbJRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:50 INFO - Running setup.py (path:/tmp/pip-6uv3Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:50 INFO - Running setup.py (path:/tmp/pip-rKJw05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:50 INFO - Running setup.py (path:/tmp/pip-LEfflB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:56:50 INFO - Running setup.py install for manifestparser 04:56:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:56:50 INFO - Running setup.py install for mozcrash 04:56:50 INFO - Running setup.py install for mozdebug 04:56:50 INFO - Running setup.py install for mozdevice 04:56:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:56:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:56:50 INFO - Running setup.py install for mozfile 04:56:50 INFO - Running setup.py install for mozhttpd 04:56:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:56:50 INFO - Running setup.py install for mozinfo 04:56:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Running setup.py install for mozInstall 04:56:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Running setup.py install for mozleak 04:56:51 INFO - Running setup.py install for mozlog 04:56:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Running setup.py install for moznetwork 04:56:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Running setup.py install for mozprocess 04:56:51 INFO - Running setup.py install for mozprofile 04:56:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Running setup.py install for mozrunner 04:56:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:56:51 INFO - Running setup.py install for mozscreenshot 04:56:51 INFO - Running setup.py install for moztest 04:56:52 INFO - Running setup.py install for mozversion 04:56:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:56:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:56:52 INFO - Cleaning up... 04:56:52 INFO - Return code: 0 04:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:52 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')]} 04:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:52 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')]} 04:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:52 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:52 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 04:56:52 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 04:56:52 INFO - Using env: {'DISPLAY': ':0', 04:56:52 INFO - 'HOME': '/home/cltbld', 04:56:52 INFO - 'LANG': 'en_US.UTF-8', 04:56:52 INFO - 'LANGUAGE': 'en_US:en', 04:56:52 INFO - 'LOGNAME': 'cltbld', 04:56:52 INFO - 'MAIL': '/var/mail/cltbld', 04:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:52 INFO - 'MOZ_NO_REMOTE': '1', 04:56:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:52 INFO - 'NO_EM_RESTART': '1', 04:56:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:52 INFO - 'PWD': '/builds/slave/test', 04:56:52 INFO - 'SHELL': '/bin/bash', 04:56:52 INFO - 'SHLVL': '1', 04:56:52 INFO - 'TERM': 'linux', 04:56:52 INFO - 'TMOUT': '86400', 04:56:52 INFO - 'USER': 'cltbld', 04:56:52 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:52 INFO - '_': '/tools/buildbot/bin/python'} 04:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:56:52 INFO - Running setup.py (path:/tmp/pip-BWT1sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:56:52 INFO - Running setup.py (path:/tmp/pip-TVDNZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:56:52 INFO - Running setup.py (path:/tmp/pip-ZwtE97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:56:52 INFO - Running setup.py (path:/tmp/pip-NXICr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:56:52 INFO - Running setup.py (path:/tmp/pip-G0VWog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:56:52 INFO - Running setup.py (path:/tmp/pip-DYS_c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:56:52 INFO - Running setup.py (path:/tmp/pip-qzLQqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:56:52 INFO - Running setup.py (path:/tmp/pip-TFHJ9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:56:52 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)) 04:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:56:52 INFO - Running setup.py (path:/tmp/pip-EufpNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:56:53 INFO - Running setup.py (path:/tmp/pip-jNvl9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:56:53 INFO - Running setup.py (path:/tmp/pip-Za4aGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:56:53 INFO - Running setup.py (path:/tmp/pip-twMGmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:56:53 INFO - Running setup.py (path:/tmp/pip-FG0yuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:56:53 INFO - Running setup.py (path:/tmp/pip-2wNlcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:53 INFO - Running setup.py (path:/tmp/pip-F1Huhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:56:53 INFO - Running setup.py (path:/tmp/pip-D8C2sd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:56:53 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)) 04:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:56:53 INFO - Running setup.py (path:/tmp/pip-StZvCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:56:53 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)) 04:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:56:53 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)) 04:56:53 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)) 04:56:53 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)) 04:56:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:56:53 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 04:56:53 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 04:56:53 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 04:56:53 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 04:56:53 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 04:56:53 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 04:56:55 INFO - Downloading blessings-1.6.tar.gz 04:56:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:56:55 INFO - Installing collected packages: blessings 04:56:55 INFO - Running setup.py install for blessings 04:56:55 INFO - Successfully installed blessings 04:56:55 INFO - Cleaning up... 04:56:55 INFO - Return code: 0 04:56:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:56:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:56 INFO - Reading from file tmpfile_stdout 04:56:56 INFO - Current package versions: 04:56:56 INFO - argparse == 1.2.1 04:56:56 INFO - blessings == 1.6 04:56:56 INFO - blobuploader == 1.2.4 04:56:56 INFO - docopt == 0.6.1 04:56:56 INFO - functools32 == 3.2.3-2 04:56:56 INFO - jsonschema == 2.5.1 04:56:56 INFO - manifestparser == 1.1 04:56:56 INFO - mozInstall == 1.12 04:56:56 INFO - mozcrash == 1.0 04:56:56 INFO - mozdebug == 0.1 04:56:56 INFO - mozdevice == 0.48 04:56:56 INFO - mozfile == 1.2 04:56:56 INFO - mozhttpd == 0.7 04:56:56 INFO - mozinfo == 0.9 04:56:56 INFO - mozleak == 0.1 04:56:56 INFO - mozlog == 3.4 04:56:56 INFO - moznetwork == 0.27 04:56:56 INFO - mozprocess == 0.23 04:56:56 INFO - mozprofile == 0.28 04:56:56 INFO - mozrunner == 6.13 04:56:56 INFO - mozscreenshot == 0.1 04:56:56 INFO - mozsystemmonitor == 0.3 04:56:56 INFO - moztest == 0.7 04:56:56 INFO - mozversion == 1.4 04:56:56 INFO - psutil == 3.1.1 04:56:56 INFO - requests == 1.2.3 04:56:56 INFO - wsgiref == 0.1.2 04:56:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:56 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 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:56 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 04:56:56 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 04:56:56 INFO - Using env: {'DISPLAY': ':0', 04:56:56 INFO - 'HOME': '/home/cltbld', 04:56:56 INFO - 'LANG': 'en_US.UTF-8', 04:56:56 INFO - 'LANGUAGE': 'en_US:en', 04:56:56 INFO - 'LOGNAME': 'cltbld', 04:56:56 INFO - 'MAIL': '/var/mail/cltbld', 04:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:56 INFO - 'MOZ_NO_REMOTE': '1', 04:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:56 INFO - 'NO_EM_RESTART': '1', 04:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:56 INFO - 'PWD': '/builds/slave/test', 04:56:56 INFO - 'SHELL': '/bin/bash', 04:56:56 INFO - 'SHLVL': '1', 04:56:56 INFO - 'TERM': 'linux', 04:56:56 INFO - 'TMOUT': '86400', 04:56:56 INFO - 'USER': 'cltbld', 04:56:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:56 INFO - '_': '/tools/buildbot/bin/python'} 04:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 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)) 04:56:56 INFO - Cleaning up... 04:56:56 INFO - Return code: 0 04:56:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf5d734f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', '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 04:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:56:56 INFO - Using env: {'DISPLAY': ':0', 04:56:56 INFO - 'HOME': '/home/cltbld', 04:56:56 INFO - 'LANG': 'en_US.UTF-8', 04:56:56 INFO - 'LANGUAGE': 'en_US:en', 04:56:56 INFO - 'LOGNAME': 'cltbld', 04:56:56 INFO - 'MAIL': '/var/mail/cltbld', 04:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:56 INFO - 'MOZ_NO_REMOTE': '1', 04:56:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:56 INFO - 'NO_EM_RESTART': '1', 04:56:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:56:56 INFO - 'PWD': '/builds/slave/test', 04:56:56 INFO - 'SHELL': '/bin/bash', 04:56:56 INFO - 'SHLVL': '1', 04:56:56 INFO - 'TERM': 'linux', 04:56:56 INFO - 'TMOUT': '86400', 04:56:56 INFO - 'USER': 'cltbld', 04:56:56 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:56 INFO - '_': '/tools/buildbot/bin/python'} 04:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:56:56 INFO - Cleaning up... 04:56:56 INFO - Return code: 0 04:56:56 INFO - Running post-action listener: _resource_record_post_action 04:56:56 INFO - Running post-action listener: _start_resource_monitoring 04:56:56 INFO - Starting resource monitoring. 04:56:56 INFO - [mozharness: 2016-11-18 12:56:56.654812Z] Finished create-virtualenv step (success) 04:56:56 INFO - [mozharness: 2016-11-18 12:56:56.655312Z] Running install step. 04:56:56 INFO - Running pre-action listener: _resource_record_pre_action 04:56:56 INFO - Running main action method: install 04:56:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:56:56 INFO - Reading from file tmpfile_stdout 04:56:56 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:56:56 INFO - Reading from file tmpfile_stdout 04:56:56 INFO - Output received: 04:56:56 INFO - Usage: mozinstall [options] installer 04:56:56 INFO - Options: 04:56:56 INFO - -h, --help show this help message and exit 04:56:56 INFO - -d DEST, --destination=DEST 04:56:56 INFO - Directory to install application into. [default: 04:56:56 INFO - "/builds/slave/test"] 04:56:56 INFO - --app=APP Application being installed. [default: firefox] 04:56:56 INFO - mkdir: /builds/slave/test/build/application 04:56:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:57:12 INFO - Reading from file tmpfile_stdout 04:57:12 INFO - Output received: 04:57:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:57:12 INFO - Running post-action listener: _resource_record_post_action 04:57:12 INFO - [mozharness: 2016-11-18 12:57:12.864968Z] Finished install step (success) 04:57:12 INFO - [mozharness: 2016-11-18 12:57:12.865210Z] Running run-tests step. 04:57:12 INFO - Running pre-action listener: _resource_record_pre_action 04:57:12 INFO - Running main action method: run_tests 04:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:57:12 INFO - Python 2.7.3 04:57:12 INFO - Return code: 0 04:57:12 INFO - grabbing minidump binary from tooltool 04:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:12 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 0x1058f60>, '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 0x1059d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:57:12 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 04:57:12 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 04:57:12 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 04:57:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:57:12 INFO - Return code: 0 04:57:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:57:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:57:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:57:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:57:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:57:12 INFO - Using env: {'DISPLAY': ':0', 04:57:12 INFO - 'HOME': '/home/cltbld', 04:57:12 INFO - 'LANG': 'en_US.UTF-8', 04:57:12 INFO - 'LANGUAGE': 'en_US:en', 04:57:12 INFO - 'LOGNAME': 'cltbld', 04:57:12 INFO - 'MAIL': '/var/mail/cltbld', 04:57:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:57:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:12 INFO - 'MOZ_NO_REMOTE': '1', 04:57:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:57:12 INFO - 'NO_EM_RESTART': '1', 04:57:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:12 INFO - 'PWD': '/builds/slave/test', 04:57:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:57:12 INFO - 'SHELL': '/bin/bash', 04:57:12 INFO - 'SHLVL': '1', 04:57:12 INFO - 'TERM': 'linux', 04:57:12 INFO - 'TMOUT': '86400', 04:57:12 INFO - 'USER': 'cltbld', 04:57:12 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050', 04:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:12 INFO - '_': '/tools/buildbot/bin/python'} 04:57:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:57:13 INFO - mozversion application_buildid: 20161118021428 04:57:13 INFO - mozversion application_changeset: 594e6d7a00aff726c2284e8a40bd0b03d63c7187 04:57:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:57:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:57:13 INFO - mozversion application_name: Firefox 04:57:13 INFO - mozversion application_remotingname: firefox-dev 04:57:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:57:13 INFO - mozversion application_vendor: Mozilla 04:57:13 INFO - mozversion application_version: 52.0a2 04:57:13 INFO - mozversion platform_buildid: 20161118021428 04:57:13 INFO - mozversion platform_changeset: 594e6d7a00aff726c2284e8a40bd0b03d63c7187 04:57:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:57:13 INFO - mozversion platform_version: 52.0a2 04:57:13 INFO - using testdate: 1479473833 04:57:13 INFO - actual date: 1479473833 04:57:13 INFO - starting webserver on 'localhost:39775' 04:57:13 INFO - SUITE-START | Running 2 tests 04:57:13 INFO - TEST-START | dromaeo_css 04:57:13 INFO - operating with platform_type : linux_ 04:57:13 INFO - Initialising browser for dromaeo_css test... 04:57:13 INFO - TEST-INFO | started process 8602 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZfqzAY/profile http://localhost:39775/getInfo.html) 04:57:16 ERROR - PROCESS | 8602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 04:57:17 INFO - PROCESS | 8602 | __metrics Screen width/height:1600/1200 04:57:17 INFO - PROCESS | 8602 | colorDepth:24 04:57:17 INFO - PROCESS | 8602 | Browser inner width/height: 1024/697 04:57:17 INFO - PROCESS | 8602 | __metrics 04:57:17 ERROR - PROCESS | 8602 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 04:57:18 INFO - TEST-INFO | 8602: exit 0 04:57:18 INFO - Browser initialized. 04:57:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:57:18 INFO - TEST-INFO | started process 8733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZfqzAY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:30 INFO - PROCESS | 8733 | RSS: Main: 152211456 04:57:30 INFO - PROCESS | 8733 | 04:58:20 INFO - PROCESS | 8733 | 1479473900220 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:00:30 INFO - PROCESS | 8733 | Cycle 1(1): loaded http://localhost:39775/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39775/tests/dromaeo/cssquery-ext.html) 05:00:31 INFO - PROCESS | 8733 | RSS: Main: 157089792 05:00:31 INFO - PROCESS | 8733 | 05:03:33 INFO - PROCESS | 8733 | Cycle 1(1): loaded http://localhost:39775/tests/dromaeo/cssquery-ext.html (next: http://localhost:39775/tests/dromaeo/cssquery-jquery.html) 05:03:34 INFO - PROCESS | 8733 | RSS: Main: 153464832 05:03:34 INFO - PROCESS | 8733 | 05:06:36 INFO - PROCESS | 8733 | Cycle 1(1): loaded http://localhost:39775/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39775/tests/dromaeo/cssquery-mootools.html) 05:06:36 INFO - PROCESS | 8733 | RSS: Main: 153395200 05:06:36 INFO - PROCESS | 8733 | 05:09:38 INFO - PROCESS | 8733 | Cycle 1(1): loaded http://localhost:39775/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39775/tests/dromaeo/cssquery-prototype.html) 05:09:39 INFO - PROCESS | 8733 | RSS: Main: 152240128 05:09:39 INFO - PROCESS | 8733 | 05:12:41 INFO - PROCESS | 8733 | Cycle 1(1): loaded http://localhost:39775/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39775/tests/dromaeo/cssquery-yui.html) 05:12:42 INFO - PROCESS | 8733 | RSS: Main: 154902528 05:12:42 INFO - PROCESS | 8733 | 05:15:44 INFO - PROCESS | 8733 | Cycle 1(1): loaded http://localhost:39775/tests/dromaeo/cssquery-yui.html (next: http://localhost:39775/tests/dromaeo/cssquery-dojo.html) 05:15:45 INFO - PROCESS | 8733 | RSS: Main: 155607040 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | __start_tp_report 05:15:45 INFO - PROCESS | 8733 | _x_x_mozilla_page_load 05:15:45 INFO - PROCESS | 8733 | _x_x_mozilla_page_load_details 05:15:45 INFO - PROCESS | 8733 | |i|pagename|runs| 05:15:45 INFO - PROCESS | 8733 | |0;dojo.html;3166.9524957125645;3190.6968837960385;3215.0837011451736;3225.483922572389;3244.789088709232;5585.636933599313;5602.943970560294;5604.131359639252;5609.551235901128;5620.353659329178;5524.088525393306;5596.300462442195;5604.551635869131;5626.099824028156;5635.380108188096;5080.898382032357;5116.846494605168;5165.070287348276;5198.0383629028565;5198.168293073109;5096.133657278272;5167.173252279636;5178.741062946838;5180.974095129519;5186.7147306898105;4966.205407134859;4969.304297398367;5179.663321884084;5185.092608793446;5193.272941788153;5050.949490505103;5059.671121377117;5084.237364395333;5115.846524604268;5163.457836927144;5012.77442515084;5089.287499750038;5105.310783044279;5118.59051275897;5128.282040514331;5362.088444964365;5485.314335708036;5514.6691198528215;5586.217929489874;5593.468620481089;5798.072308430631;5823.039198532279;5838.124281357788;5908.231929849092;5920;5873.324567674729;5888.941110588882;5892.145638882381;5955.791547295824;5979.730912108966;5564.749586268668;5566.749496272637;5568.9443105569235;5578.358488773762;5579.469950354791;5999.100134979701;6037.305709843336;6062.605930614496;6064.332923378425;6096.329403765582;5801.158831969341;5832.125181222766;5855.443732845373;5856.882862342729;5870;5742.3396309424115;5778.855528611734;5875;5905.527557795366;5914.9112763308585;5817.127430885401;5861.267341582302;5926.436988486087;5934.109883517421;6007.459328660441;5928.555358348055;5949.345571987078;5953.464188223081;5953.821385358447;5970.611910225822;4434.179676759745;4609.216433206363;4636.698614590041;4638.907221855611;4642.3500709900645;4043.9191216175514;4053.756774593534;4081.387791831249;4099.959000409957;4109.712320137622;5635.154726791015;5646.57650676201;5692.260006199168;5693.601447898607;5703.7433315500075;5851.561132915049;5932.851678708067;5947.762089516371;5949.345571987078;5963.970180149158;5583.246261754611;5605.103183490622;5632.04255276604;5635.957347890653;5638.069718496484;5065.037642847848;5068;5088.185890257541;5101.642884998015;5109.56568691658;6153.292371377349;6166.383361663798;6187;6190.2571691397325;6195.845103872439;5746.712664366682;5789.2184555086205;5918.378570250234;5922.378150294157;5943.435373639497;6193.535484838565;6202.255729312511;6205.81382558524;6212.596181248205;6213.099100630474;5794.246747922743;5810.622309549865;5843.152742852348;5851.824445266649;5867.442592953663;5847.619904706181;5873.911891321548;5878.500327472213;5908.970455147869;5916.437938395846;5782.884342313214;5786.710664466844;5787.826365209051;5788.305403351625;5795.1017592273265;5771.422857714363;5778.422157784188;5800.854978625568;5814.447627475383;5864.149698293809;5699.743511542073;5737.627054241628;5760.884782304414;5765.365809760839;5773.884522309614;5798.217240672455;5808.361080281081;5821.505172060253;5882.323532793784;5886.087656413263;5559.52744016747;5615.129654903497;5726.828195154152;5744.971275143597;5760.510356619734 05:15:45 INFO - PROCESS | 8733 | |1;ext.html;560.812127937141;625.3590070178068;644.7711062572785;655.8819412505753;673.5117040145894;45666.77166614166;46973.999999999956;47034;50007.74996125014;50109;46266.768666156706;46796.53203467964;46803.29795053069;46956;47027.76486117573;8728.43265187764;8863.069377715343;8876.423032502867;8877.289816814638;8919.24186444153;8701.43440676354;8758.167974042455;8765.474071555727;8767.079456657055;8829.249513791336;8771.16673915977;8828.602712877904;8843.115688431137;8854.822903541924;8869.512176830272;8792.736217913473;8811.427257228259;8824.514651694155;8842.646294148259;8869.645214191425;8687.826243475096;8751.737447876574;8802.515861627608;8831.02858685544;8843.33674974373;44685.55314446847;44969.325460118125;45175.548244517464;45220.54779452229;45237.32144017842;3634.6728794408364;3776.3202623527754;3822.57951625321;3825.08198032473;4121.732087414309;33347;33450.163745906306;33599.664003359896;33786.662133378595;33792.49311260333;4366.3013917773005;4378.452693413324;4401.097774956158;4478.171538265431;4493.438320209973;362842;364863;366477;366894;368123;64956.67521662456;65525.67237163784;65616.34383656198;65627.67186164134;65761.67119164373;68072;68328.31671683319;68412;68459.31540684629;68797.3120268791;17922.5519362017;17948.55128621795;18043.729344059848;18130.546736331435;18169.182386792363;14632.122072675673;14707.705845883236;14733.189674568002;14799.408023678932;14832.406703731946;18413.820571542314;19211;19457.28543409706;19466.70799938002;19555.413337599894;6519.739210431624;6695.1965764107645;6703.195616526048;6742.730290788313;6810.318968103249;954.0221273194892;1049.1187402581868;1073.92070968676;1079.9568017279378;1166.5333866453486;33080;33100.83449582737;33148.834255829046;33154.5026824593;33272.83363583215;1061.8850207282323;1080.9297395669257;1105.8009558279425;1160.4545863444168;1245.7383949370553;16620.036078657522;17141.22864471077;17172.65654686899;17228.62171026315;17295;484810;486113;486318;488912;493472;62589.687051565365;62594.68702656458;62783.74432511324;62807;62980.37019629837;1410.7108042851191;1414.8019277301187;1422.6087825847974;1447.1244896837684;1457.8031965684497;31473.8426307867;31975.36049278955;32394;32638.83680581582;32986;53879;53912.73043634757;54141.729291353295;54317;54348.456515434336;437009;437650;439549;439903;442047;44451.55548444474;44956;44962.77518612386;45328.54671453243;45543.31685024661;51204.74397627988;51704;52231.21653175129;52422.47577524176;53171.202431962774;42933.92665183396;43148.92127696833;44395;44476;45617.77191114023;42394.1521169581;43440;44143.33784993163;44166.84415693742;44256.557434425245;37667.81166094152;38041.42937855879;43792.78103609462;45295.773521132185;46562.06875862532;44167.33748993703;45579.316310256036;45830;47057.2941405886;47332.763336183096;35108.824455877555;35362;35470.822645886605;35554.28891422209;35564.466533002545 05:15:45 INFO - PROCESS | 8733 | |2;jquery.html;408.7527046137085;424.2840207150433;427.7262551966742;432.94371731674886;434.79564604635823;18528.90735546322;19494;19885.403437896868;19895.303664371713;20132.194712211513;19683.803161968375;20036.797792132482;20476.590468190665;20523.38429847103;20733.274335398262;5700.572457065716;6018.15745795589;6034.034554471264;6039.335673075958;6047.546434017444;4475.709078909877;5885.411458854123;5979.1330257112695;6680.83297917551;6741.426978706816;6742.190937087532;6794.660266986655;6827.897581536281;6837.453003759687;6837.623930683811;5698.8290351289525;5851;5936.376680448577;5960.582759206835;6032.698365081728;5660.773569057233;5815.691469419389;5831.096180092092;5869.1196320551835;5881.676622759887;14589.854101459061;14758.63103422423;14868.925655371762;15053.397864085424;15149.545513634608;2298.287530865437;2330.2077293720217;2855.6858745537975;2941.58817765513;3066.402051599939;11334.093272538259;11566.653000409917;12061.698457538632;12151;15519.379224830993;1911.3119277060248;2045.8016786320181;2046.7953204679413;2068.493219161315;2076.1384025629345;84554;84875.57562212211;87971.56014219952;88051.11948880494;88093.55953220258;11957.162998590014;11969.700757481132;12017.699557511132;12185.573504927284;12409.317487538272;17343.39298124585;17421.82578174202;17427.825721742873;17478.563035924202;17487.562810929576;8467.449615774955;8552.786180345542;8663.306935445149;8773.034966153718;8788.648454061893;7998.360131189491;8163.224899518883;8187.549684767276;8246.257836794717;8312.625931832961;5150.098732721759;5162.3030890830005;5206.609504287194;5234.947650523446;5320.920186197211;1780.946571602854;1858.87917285376;1900.116445852685;1997.2809788476136;2000.1299434745931;881.3037700216757;984.3945973226414;1002.7092143278368;1051.6687243518268;1056.3345092591771;19521.414357569294;20064.69902951457;20084.799152008294;20213.797862021485;20365.08357123933;984.8473486609587;1013.8331457708811;1028.665683652816;1039.6776999130293;1041.8801837788599;10638.255322127377;11187.386730704897;11241.381724005258;11257.043151332065;11277.436128193558;508432;514112;515334;519264;525086;89722;89875;89876;92944;95276.52361738146;1046.529061922138;1085.4355735017746;1088.613542192526;1090.0407641275626;1104.4422566603814;17465.82534174642;17477.55032769736;17717.29130834752;17741.822581774533;18101.637967240844;42211.36682949697;42407;43299.13401732011;43528.34707479454;44291.89270268269;54551.45448545464;57090.42909570851;58084.709576451845;58556.12165817431;62048.68975655093;8029.3175080118845;8373.66505339804;8384.53885036329;8630.78423039429;8635.740927772176;9818.067283608047;13273.137246078973;13840.909884867298;13846.376913038735;14008.369623367176;12230.715774843513;12528.87471125277;12642.494300227889;12670.746585068062;12786.872131278567;11579.478923448296;11710.355930423908;11786.469608867794;12183;12597.496100156257;12705.301208433624;12770.16993895431;12782.296973666538;13154;13222.867771322164;8307.792305192419;8415;8581.442206256574;8662.04717481064;8678.045415004472;11915.463804128662;12044.156909016636;12158.574449894211;12208.633740987785;12798.360081996048 05:15:45 INFO - PROCESS | 8733 | |3;mootools.html;1504.9247537623116;1535.9846401535985;1689.3833750681006;1811.9762334281138;1825.7261410788387;7684.692612295516;7873.566953817538;8129.187081291875;8669.69656062038;8679.349048821332;8136.674533018687;8333.125021872707;8348.791280217982;8548.187922147401;8603.827923441528;2457.6067829147387;2488.5271798358253;2500.962485562718;2504.0860086068546;2510.435152090774;2470.2465747946867;2533.1513942829174;2534.3917459809695;2538.6953565572157;2543.135333986444;2423.3941514621347;2446.4617784087563;2474.40614252579;2479.2562231330617;2481.1688084491716;2394.5330660521117;2410.915617953372;2424.284835973392;2427.6965379327585;2443.8289319747623;2361.6221404575185;2372.774586414288;2389.235444657693;2391.485830546441;2416.395901024744;8453.323734101257;8496.235338819473;8587.055423903366;8599.61301741423;8622.698205562838;5098.59211263098;5229.058769421503;5234.057869583474;5271.683698978073;5330.813421530228;3503.1417302760733;3566.3045706087323;3585.4621806728937;3592.4431713084514;3710.962890371116;1227.9631611051682;1240.8448943882015;1271.7520083583704;1295.7408518296284;1311.645855618987;11398.316101033965;11486.712832179179;11502.194846360759;11507.769844603145;11615.76768464626;4638.489766125724;4652.418447694038;4725.9054818904115;4747.86051347674;4768.9523104769205;9265.675701350421;9349.90650093504;9362.344635875423;9365.578548965314;9378.109079637423;5208.401033881152;5224.52979231871;5237.659552129099;5238.135707608279;5253.789848406097;4774.737389443544;4848.00615873745;4907.141250281186;4911.607071434277;4944.357233559686;3738.6261373862394;3802.733808633369;3819.579846216914;3853.190829925691;3882.1265215326325;1212.0969877441362;1212.7695737809788;1214.6598952293373;1221.7922953097996;1222.957196498136;987.6592575561419;996.9351992120634;1013.1489548779061;1015.167562598662;1038.050184081572;5652.18043383707;5686.289213848269;5753.252077229933;5899.410058994066;5939.792107276225;496.9850904472872;499.86003918902765;504.92678561608363;508.51182864449805;515.8246196293203;3766.246750649881;4078.7552746835286;4165.562615925345;4172.687048471377;4243.978780106141;10256.487175641189;10563.841542376716;10614.840777388345;10646.095081917969;10689.144868410509;9926.553305101143;10461.215408844368;10509.579616815394;10516.842247366296;10582.994615511514;7694.0767107946285;8099.757007289791;8101.392395570356;8115.594220288962;8163.551004694798;5558.194061861089;5567.860803479945;5580.609357344947;5606.943930560642;5619.325680918152;9623.903760962301;9637.37357071788;9704.563294651616;9770;9803;9253.491057991605;9468.242540596873;9525.380850244712;9707.077827606367;9722.562484688347;7929.365650748042;8012.919870801217;8098.75703728889;8174.386920980831;8369.079401265977;8453.239208471266;8472.83054338922;8496.300739851931;8569.828603427772;8581.098984606526;7504.512206706547;7554.697812087455;7617.124030736536;7643.312101910855;7912.881306780288;7125.857482850418;7227.349538541556;7394.038774959221;7403.259674032769;7541.321281084729;6765.458763299022;6778;6791.93208067913;6933.064036355229;6958.095447591781;4828.686135401188;4869.537393947569;4889.706617602955;4980.576650984707;5052.343195384577;5086.720230387365;5121.539061484485;5215.113430716711;5234.13636749932;5363.490468405495 05:15:45 INFO - PROCESS | 8733 | |4;prototype.html;348.56255399473656;357.4691582999246;359.23482981249924;360.40353215428473;361.86249225294387;5500.504954554094;5602;5602.299712535933;5626.046325679021;5643.153526970957;5547.750351234194;5550.47270509302;5565.3878073412;5597.272354593907;5600.943990560093;4277.786110694468;4321.589449002356;4373.059792144688;4391.451068616423;4420.823167073313;4349.7390156590545;4367.323064924942;4378.5183629800695;4382.5398333175035;4383.189110014641;4301.225779359714;4341.023269764293;4341.826326946918;4344.087741574273;4350.021245219816;4164.1255336379545;4340.305551111823;4352.303631418989;4375.584319489643;4393.472783266028;3893.143508428141;3897.337452633059;3906.9609303907164;3909.8240579174008;3960.1089754805225;5440.972795135999;5477.014137455257;5489.752961116759;5546.417626149277;5560.525566123077;4885.658003939726;5044.873878153039;5044.949550504484;5056.84829455117;5090.898182036339;5845.678487683176;5849.151872978437;5854.151148083547;5856.62369343204;5859.501942334907;4310.224159651261;4326.221280169569;4328.870133895956;4341.934870976938;4346.782660866944;5752.309722833245;5931.4661680448535;6010.265329275213;6100.359462256488;6122.510199184099;4275;4290.442242508454;4305.763183024901;4306;4321.827126914951;4372.956270437255;4392.209402307615;4396.340548917624;4404.810701110682;4419.690621656518;4915.18899381598;4983.9252411213865;4988.700677959334;4994.375703037121;5008.949910500848;5804.622699524517;5825.359210486843;5849.327327357409;5854.648721076749;5864.179014937912;1481.82935480971;1514.1899083990234;1515.9393624255126;1516.8938174327911;1521.8890210146656;1008.8839783425;1056.615833258434;1066.248294952057;1076.5424694504804;1087.4671411008549;5473.151661492475;5514.773857293529;5538.47384498472;5601.383847776741;5642.376295022834;5871.6770577618645;5875;5904.498117659961;5916;5918.822435326947;5293.173855020012;5349.732513374316;5491.862703432366;5535.667859928417;5606.747696353674;3040.528718048706;3048.192229059301;3055.343101233201;3062.892798752033;3091.8144911305394;5800.651960882361;6005.369436209223;6035.366286539938;6041.516678665696;6066.908996365058;5774.855628609234;5845.853853653608;5846.356900740915;5847.853803654943;5867.794627188028;6009.45914867664;6033.698315084228;6038.305594856648;6072.544559158081;6086.330503644595;5636.577256705681;5691.345495267931;5727.055035919193;5727.427257274406;5766.3368712598585;5665.518430933417;5682.119271512922;5707.886962042528;5721.914171287351;5751.626144300774;6072.544559158169;6088.847778805565;6255.186825712628;6305.211848518935;6316.873662526816;4364.38898554209;4377.365282034151;4396.4064851244675;4400.92177416535;4421.447319085114;5954.19618351517;6064.4995503020655;6081.817545473643;6142.232220972379;6157.445829875153;5862.530997520274;5865.648061116347;5875.618084824473;5880.735366908414;5923.911141332969;5864.501517370901;5903.350631430453;5916.852078698067;5917.319508256605;5930.466258036798;5649.830505084854;5760.8271751847515;5790.826275211751;5791.681457519709;5844.2986841577585;5872.941270587239;5882.735276912464;5955.315138759098;5956.285245770535;5958.7616495341435;5606.271184745957;5662.320521537442;5732.914006289992;5795.913061304;5811.331696854916 05:15:45 INFO - PROCESS | 8733 | |5;yui.html;769.7844603511018;787.7715462515871;830.5556527257918;879.4020066354876;905.2531661379363;15390.538283851489;15975.520734377973;16133.43532976346;16192.35230590778;16245.756313655274;14532.636684082876;14549.709005819877;15481;16290.674186516262;16319.51041468755;834.845553572588;858.3433673239945;860.0797147052656;860.389123722158;864.6454953469079;844.2317491083115;850.0606829453458;850.2475309351207;850.8468475674376;850.8978922529305;892.4912799704172;893.8882639670041;894.5482531321674;894.8702438146465;897.0222457521301;891.38494438837;891.4829398948594;894.2890402130322;895.1138373010738;896.318797713739;652.2466551133449;652.6280020388381;652.6704014472708;653.137858027404;655.8032590222962;15459.61350966235;15480.071195728293;15495.070295782176;15521.534353969399;15613.297401616954;14490.058146220568;14883;14958.47645332419;15015.474458394014;15053.623854127165;11308.491117899714;11507.482163302671;11603.477843497063;11688.883111168865;11863.644090677293;3774.3960966245545;3789.905252368685;3806.2663289523553;3806.505154329947;3901.0247438140464;68636.68765297349;70295.29704702938;70560.29439705588;70784;72529.63735181344;10582.115727607466;10627.309224900511;10821;10835;10925.836112458319;19491.512712182026;19506;19510.122044508033;19515;19533;7729.420293478011;7998.960135182389;8153.959230203811;8243.422960392834;8313.958430207811;4587.7017993830295;4681.625469962395;4800.399950006249;4828.396450443694;4830.782614782343;3337.5828021497314;3440.071180781175;3445;3463.3939060664284;3486.877959271413;619.1826788638954;628.1237673445518;634.4765568406084;635.6186288227027;636.4431122767578;718.4647437658978;730.2332550821616;736.8820988641899;746.7834328044914;765.59806101797;9775.217982561378;9862;9898.158656514133;9934.155596774355;10576.947115264375;656.7832615236961;712.4478529139958;737.4616529933072;742.1354122447397;750.0961341583379;4329.631981281564;4488.192125417456;4551.271796512542;4623.722576645412;4629.629629629621;55325.72337138288;55935.44064559384;55977;76834.84747728788;79484;53701.731491343075;63923;65041.34958650353;80504;81030;42868.14263714771;42928.35607465891;55586.44413555894;64776;65819;9398.389104708172;9940.304178707422;10158.746031349276;10501.579936802747;10563.841542376716;44801.55198447974;46618.300725488465;47158;47460.28809567928;48443;65602.34397655963;66533.66733166497;67106.66446667735;67230;67795;12395.62813115608;12869.163504372185;12952.935235323763;13112.672183195114;13441.932790335986;13423.932880335537;13540.255285958972;13932.651683707989;14102.435902564193;14591.197484138474;12928.482860685843;13082.672933176747;13136.868631313564;13221.140625859289;13236.66908327261;13633.659158521117;13657.931710341782;13684;13725.588232353046;13772.24252666113;13080.345982701017;13089.672758181121;13197.604071877859;13388.464461421434;13566.118202316818;11134.27627204229;11181.776364472502;11300.547978080785;11773;12241.449134789134;11364.715882103013;11722.062235021349;11821.881781182077;11823.704407389883;11890.28658280506 05:15:45 INFO - PROCESS | 8733 | __end_tp_report 05:15:45 INFO - PROCESS | 8733 | __start_cc_report 05:15:45 INFO - PROCESS | 8733 | _x_x_mozilla_cycle_collect,319 05:15:45 INFO - PROCESS | 8733 | __end_cc_report 05:15:45 INFO - PROCESS | 8733 | __startTimestamp1479474944999__endTimestamp 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | ------- Summary: start ------- 05:15:45 INFO - PROCESS | 8733 | Number of tests: 6 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | [#0] dojo.html Cycles:165 Average:5523.35 Median:5746.71 stddev:611.20 (10.6%) stddev-sans-first:584.45 05:15:45 INFO - PROCESS | 8733 | Values: 3167.0 3190.7 3215.1 3225.5 3244.8 5585.6 5602.9 5604.1 5609.6 5620.4 5524.1 5596.3 5604.6 5626.1 5635.4 5080.9 5116.8 5165.1 5198.0 5198.2 5096.1 5167.2 5178.7 5181.0 5186.7 4966.2 4969.3 5179.7 5185.1 5193.3 5050.9 5059.7 5084.2 5115.8 5163.5 5012.8 5089.3 5105.3 5118.6 5128.3 5362.1 5485.3 5514.7 5586.2 5593.5 5798.1 5823.0 5838.1 5908.2 5920.0 5873.3 5888.9 5892.1 5955.8 5979.7 5564.7 5566.7 5568.9 5578.4 5579.5 5999.1 6037.3 6062.6 6064.3 6096.3 5801.2 5832.1 5855.4 5856.9 5870.0 5742.3 5778.9 5875.0 5905.5 5914.9 5817.1 5861.3 5926.4 5934.1 6007.5 5928.6 5949.3 5953.5 5953.8 5970.6 4434.2 4609.2 4636.7 4638.9 4642.4 4043.9 4053.8 4081.4 4100.0 4109.7 5635.2 5646.6 5692.3 5693.6 5703.7 5851.6 5932.9 5947.8 5949.3 5964.0 5583.2 5605.1 5632.0 5636.0 5638.1 5065.0 5068.0 5088.2 5101.6 5109.6 6153.3 6166.4 6187.0 6190.3 6195.8 5746.7 5789.2 5918.4 5922.4 5943.4 6193.5 6202.3 6205.8 6212.6 6213.1 5794.2 5810.6 5843.2 5851.8 5867.4 5847.6 5873.9 5878.5 5909.0 5916.4 5782.9 5786.7 5787.8 5788.3 5795.1 5771.4 5778.4 5800.9 5814.4 5864.1 5699.7 5737.6 5760.9 5765.4 5773.9 5798.2 5808.4 5821.5 5882.3 5886.1 5559.5 5615.1 5726.8 5745.0 5760.5 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | [#1] ext.html Cycles:180 Average:61767.85 Median:44966.05 stddev:114406.71 (254.4%) stddev-sans-first:114635.35 05:15:45 INFO - PROCESS | 8733 | Values: 560.8 625.4 644.8 655.9 673.5 45666.8 46974.0 47034.0 50007.7 50109.0 46266.8 46796.5 46803.3 46956.0 47027.8 8728.4 8863.1 8876.4 8877.3 8919.2 8701.4 8758.2 8765.5 8767.1 8829.2 8771.2 8828.6 8843.1 8854.8 8869.5 8792.7 8811.4 8824.5 8842.6 8869.6 8687.8 8751.7 8802.5 8831.0 8843.3 44685.6 44969.3 45175.5 45220.5 45237.3 3634.7 3776.3 3822.6 3825.1 4121.7 33347.0 33450.2 33599.7 33786.7 33792.5 4366.3 4378.5 4401.1 4478.2 4493.4 362842.0 364863.0 366477.0 366894.0 368123.0 64956.7 65525.7 65616.3 65627.7 65761.7 68072.0 68328.3 68412.0 68459.3 68797.3 17922.6 17948.6 18043.7 18130.5 18169.2 14632.1 14707.7 14733.2 14799.4 14832.4 18413.8 19211.0 19457.3 19466.7 19555.4 6519.7 6695.2 6703.2 6742.7 6810.3 954.0 1049.1 1073.9 1080.0 1166.5 33080.0 33100.8 33148.8 33154.5 33272.8 1061.9 1080.9 1105.8 1160.5 1245.7 16620.0 17141.2 17172.7 17228.6 17295.0 484810.0 486113.0 486318.0 488912.0 493472.0 62589.7 62594.7 62783.7 62807.0 62980.4 1410.7 1414.8 1422.6 1447.1 1457.8 31473.8 31975.4 32394.0 32638.8 32986.0 53879.0 53912.7 54141.7 54317.0 54348.5 437009.0 437650.0 439549.0 439903.0 442047.0 44451.6 44956.0 44962.8 45328.5 45543.3 51204.7 51704.0 52231.2 52422.5 53171.2 42933.9 43148.9 44395.0 44476.0 45617.8 42394.2 43440.0 44143.3 44166.8 44256.6 37667.8 38041.4 43792.8 45295.8 46562.1 44167.3 45579.3 45830.0 47057.3 47332.8 35108.8 35362.0 35470.8 35554.3 35564.5 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | [#2] jquery.html Cycles:180 Average:30106.72 Median:2187.21 stddev:85062.22 (3889.1%) stddev-sans-first:85271.62 05:15:45 INFO - PROCESS | 8733 | Values: 408.8 424.3 427.7 432.9 434.8 18528.9 19494.0 19885.4 19895.3 20132.2 19683.8 20036.8 20476.6 20523.4 20733.3 5700.6 6018.2 6034.0 6039.3 6047.5 4475.7 5885.4 5979.1 6680.8 6741.4 6742.2 6794.7 6827.9 6837.5 6837.6 5698.8 5851.0 5936.4 5960.6 6032.7 5660.8 5815.7 5831.1 5869.1 5881.7 14589.9 14758.6 14868.9 15053.4 15149.5 2298.3 2330.2 2855.7 2941.6 3066.4 11334.1 11566.7 12061.7 12151.0 15519.4 1911.3 2045.8 2046.8 2068.5 2076.1 84554.0 84875.6 87971.6 88051.1 88093.6 11957.2 11969.7 12017.7 12185.6 12409.3 17343.4 17421.8 17427.8 17478.6 17487.6 8467.4 8552.8 8663.3 8773.0 8788.6 7998.4 8163.2 8187.5 8246.3 8312.6 5150.1 5162.3 5206.6 5234.9 5320.9 1780.9 1858.9 1900.1 1997.3 2000.1 881.3 984.4 1002.7 1051.7 1056.3 19521.4 20064.7 20084.8 20213.8 20365.1 984.8 1013.8 1028.7 1039.7 1041.9 10638.3 11187.4 11241.4 11257.0 11277.4 508432.0 514112.0 515334.0 519264.0 525086.0 89722.0 89875.0 89876.0 92944.0 95276.5 1046.5 1085.4 1088.6 1090.0 1104.4 17465.8 17477.6 17717.3 17741.8 18101.6 42211.4 42407.0 43299.1 43528.3 44291.9 54551.5 57090.4 58084.7 58556.1 62048.7 8029.3 8373.7 8384.5 8630.8 8635.7 9818.1 13273.1 13840.9 13846.4 14008.4 12230.7 12528.9 12642.5 12670.7 12786.9 11579.5 11710.4 11786.5 12183.0 12597.5 12705.3 12770.2 12782.3 13154.0 13222.9 8307.8 8415.0 8581.4 8662.0 8678.0 11915.5 12044.2 12158.6 12208.6 12798.4 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | [#3] mootools.html Cycles:180 Average:5658.30 Median:2797.62 stddev:3097.95 (110.7%) stddev-sans-first:3090.92 05:15:45 INFO - PROCESS | 8733 | Values: 1504.9 1536.0 1689.4 1812.0 1825.7 7684.7 7873.6 8129.2 8669.7 8679.3 8136.7 8333.1 8348.8 8548.2 8603.8 2457.6 2488.5 2501.0 2504.1 2510.4 2470.2 2533.2 2534.4 2538.7 2543.1 2423.4 2446.5 2474.4 2479.3 2481.2 2394.5 2410.9 2424.3 2427.7 2443.8 2361.6 2372.8 2389.2 2391.5 2416.4 8453.3 8496.2 8587.1 8599.6 8622.7 5098.6 5229.1 5234.1 5271.7 5330.8 3503.1 3566.3 3585.5 3592.4 3711.0 1228.0 1240.8 1271.8 1295.7 1311.6 11398.3 11486.7 11502.2 11507.8 11615.8 4638.5 4652.4 4725.9 4747.9 4769.0 9265.7 9349.9 9362.3 9365.6 9378.1 5208.4 5224.5 5237.7 5238.1 5253.8 4774.7 4848.0 4907.1 4911.6 4944.4 3738.6 3802.7 3819.6 3853.2 3882.1 1212.1 1212.8 1214.7 1221.8 1223.0 987.7 996.9 1013.1 1015.2 1038.1 5652.2 5686.3 5753.3 5899.4 5939.8 497.0 499.9 504.9 508.5 515.8 3766.2 4078.8 4165.6 4172.7 4244.0 10256.5 10563.8 10614.8 10646.1 10689.1 9926.6 10461.2 10509.6 10516.8 10583.0 7694.1 8099.8 8101.4 8115.6 8163.6 5558.2 5567.9 5580.6 5606.9 5619.3 9623.9 9637.4 9704.6 9770.0 9803.0 9253.5 9468.2 9525.4 9707.1 9722.6 7929.4 8012.9 8098.8 8174.4 8369.1 8453.2 8472.8 8496.3 8569.8 8581.1 7504.5 7554.7 7617.1 7643.3 7912.9 7125.9 7227.3 7394.0 7403.3 7541.3 6765.5 6778.0 6791.9 6933.1 6958.1 4828.7 4869.5 4889.7 4980.6 5052.3 5086.7 5121.5 5215.1 5234.1 5363.5 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | [#4] prototype.html Cycles:180 Average:4909.62 Median:5581.33 stddev:1418.32 (25.4%) stddev-sans-first:1380.37 05:15:45 INFO - PROCESS | 8733 | Values: 348.6 357.5 359.2 360.4 361.9 5500.5 5602.0 5602.3 5626.0 5643.2 5547.8 5550.5 5565.4 5597.3 5600.9 4277.8 4321.6 4373.1 4391.5 4420.8 4349.7 4367.3 4378.5 4382.5 4383.2 4301.2 4341.0 4341.8 4344.1 4350.0 4164.1 4340.3 4352.3 4375.6 4393.5 3893.1 3897.3 3907.0 3909.8 3960.1 5441.0 5477.0 5489.8 5546.4 5560.5 4885.7 5044.9 5044.9 5056.8 5090.9 5845.7 5849.2 5854.2 5856.6 5859.5 4310.2 4326.2 4328.9 4341.9 4346.8 5752.3 5931.5 6010.3 6100.4 6122.5 4275.0 4290.4 4305.8 4306.0 4321.8 4373.0 4392.2 4396.3 4404.8 4419.7 4915.2 4983.9 4988.7 4994.4 5008.9 5804.6 5825.4 5849.3 5854.6 5864.2 1481.8 1514.2 1515.9 1516.9 1521.9 1008.9 1056.6 1066.2 1076.5 1087.5 5473.2 5514.8 5538.5 5601.4 5642.4 5871.7 5875.0 5904.5 5916.0 5918.8 5293.2 5349.7 5491.9 5535.7 5606.7 3040.5 3048.2 3055.3 3062.9 3091.8 5800.7 6005.4 6035.4 6041.5 6066.9 5774.9 5845.9 5846.4 5847.9 5867.8 6009.5 6033.7 6038.3 6072.5 6086.3 5636.6 5691.3 5727.1 5727.4 5766.3 5665.5 5682.1 5707.9 5721.9 5751.6 6072.5 6088.8 6255.2 6305.2 6316.9 4364.4 4377.4 4396.4 4400.9 4421.4 5954.2 6064.5 6081.8 6142.2 6157.4 5862.5 5865.6 5875.6 5880.7 5923.9 5864.5 5903.4 5916.9 5917.3 5930.5 5649.8 5760.8 5790.8 5791.7 5844.3 5872.9 5882.7 5955.3 5956.3 5958.8 5606.3 5662.3 5732.9 5795.9 5811.3 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - PROCESS | 8733 | [#5] yui.html Cycles:180 Average:17165.09 Median:4605.71 stddev:21377.74 (464.2%) stddev-sans-first:21402.26 05:15:45 INFO - PROCESS | 8733 | Values: 769.8 787.8 830.6 879.4 905.3 15390.5 15975.5 16133.4 16192.4 16245.8 14532.6 14549.7 15481.0 16290.7 16319.5 834.8 858.3 860.1 860.4 864.6 844.2 850.1 850.2 850.8 850.9 892.5 893.9 894.5 894.9 897.0 891.4 891.5 894.3 895.1 896.3 652.2 652.6 652.7 653.1 655.8 15459.6 15480.1 15495.1 15521.5 15613.3 14490.1 14883.0 14958.5 15015.5 15053.6 11308.5 11507.5 11603.5 11688.9 11863.6 3774.4 3789.9 3806.3 3806.5 3901.0 68636.7 70295.3 70560.3 70784.0 72529.6 10582.1 10627.3 10821.0 10835.0 10925.8 19491.5 19506.0 19510.1 19515.0 19533.0 7729.4 7999.0 8154.0 8243.4 8314.0 4587.7 4681.6 4800.4 4828.4 4830.8 3337.6 3440.1 3445.0 3463.4 3486.9 619.2 628.1 634.5 635.6 636.4 718.5 730.2 736.9 746.8 765.6 9775.2 9862.0 9898.2 9934.2 10576.9 656.8 712.4 737.5 742.1 750.1 4329.6 4488.2 4551.3 4623.7 4629.6 55325.7 55935.4 55977.0 76834.8 79484.0 53701.7 63923.0 65041.3 80504.0 81030.0 42868.1 42928.4 55586.4 64776.0 65819.0 9398.4 9940.3 10158.7 10501.6 10563.8 44801.6 46618.3 47158.0 47460.3 48443.0 65602.3 66533.7 67106.7 67230.0 67795.0 12395.6 12869.2 12952.9 13112.7 13441.9 13423.9 13540.3 13932.7 14102.4 14591.2 12928.5 13082.7 13136.9 13221.1 13236.7 13633.7 13657.9 13684.0 13725.6 13772.2 13080.3 13089.7 13197.6 13388.5 13566.1 11134.3 11181.8 11300.5 11773.0 12241.4 11364.7 11722.1 11821.9 11823.7 11890.3 05:15:45 INFO - PROCESS | 8733 | -------- Summary: end -------- 05:15:45 INFO - PROCESS | 8733 | 05:15:45 INFO - TEST-INFO | 8733: exit 0 05:15:45 INFO - TEST-OK | dromaeo_css | took 1112634ms 05:15:45 INFO - TEST-START | kraken 05:15:45 INFO - operating with platform_type : linux_ 05:15:45 INFO - Initialising browser for kraken test... 05:15:45 INFO - TEST-INFO | started process 9109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplO0xhb/profile http://localhost:39775/getInfo.html) 05:15:48 ERROR - PROCESS | 9109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 05:15:50 INFO - PROCESS | 9109 | __metrics Screen width/height:1600/1200 05:15:50 INFO - PROCESS | 9109 | colorDepth:24 05:15:50 INFO - PROCESS | 9109 | Browser inner width/height: 1024/697 05:15:50 INFO - PROCESS | 9109 | __metrics 05:15:50 ERROR - PROCESS | 9109 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3178: TypeError: this.tabs is undefined 05:15:51 INFO - TEST-INFO | 9109: exit 0 05:15:51 INFO - Browser initialized. 05:15:51 INFO - Running cycle 1/1 for kraken test... 05:15:51 INFO - TEST-INFO | started process 9244 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplO0xhb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:03 INFO - PROCESS | 9244 | RSS: Main: 152162304 05:16:03 INFO - PROCESS | 9244 | 05:16:05 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39775/tests/kraken/driver.html?testName=audio-beat-detection) 05:16:06 INFO - PROCESS | 9244 | RSS: Main: 157233152 05:16:06 INFO - PROCESS | 9244 | 05:16:09 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39775/tests/kraken/driver.html?testName=audio-dft) 05:16:09 INFO - PROCESS | 9244 | RSS: Main: 155369472 05:16:09 INFO - PROCESS | 9244 | 05:16:12 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39775/tests/kraken/driver.html?testName=audio-fft) 05:16:13 INFO - PROCESS | 9244 | RSS: Main: 155729920 05:16:13 INFO - PROCESS | 9244 | 05:16:15 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39775/tests/kraken/driver.html?testName=audio-oscillator) 05:16:15 INFO - PROCESS | 9244 | RSS: Main: 155680768 05:16:15 INFO - PROCESS | 9244 | 05:16:18 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39775/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:16:18 INFO - PROCESS | 9244 | RSS: Main: 155373568 05:16:18 INFO - PROCESS | 9244 | 05:16:21 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39775/tests/kraken/driver.html?testName=imaging-darkroom) 05:16:22 INFO - PROCESS | 9244 | RSS: Main: 158240768 05:16:22 INFO - PROCESS | 9244 | 05:16:25 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39775/tests/kraken/driver.html?testName=imaging-desaturate) 05:16:26 INFO - PROCESS | 9244 | RSS: Main: 158318592 05:16:26 INFO - PROCESS | 9244 | 05:16:28 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39775/tests/kraken/driver.html?testName=json-parse-financial) 05:16:29 INFO - PROCESS | 9244 | RSS: Main: 158363648 05:16:29 INFO - PROCESS | 9244 | 05:16:31 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39775/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:16:31 INFO - PROCESS | 9244 | RSS: Main: 157995008 05:16:31 INFO - PROCESS | 9244 | 05:16:33 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:16:34 INFO - PROCESS | 9244 | RSS: Main: 157544448 05:16:34 INFO - PROCESS | 9244 | 05:16:36 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:16:36 INFO - PROCESS | 9244 | RSS: Main: 157908992 05:16:36 INFO - PROCESS | 9244 | 05:16:39 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:16:40 INFO - PROCESS | 9244 | RSS: Main: 157691904 05:16:40 INFO - PROCESS | 9244 | 05:16:42 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:16:43 INFO - PROCESS | 9244 | RSS: Main: 158457856 05:16:43 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | Cycle 1(1): loaded http://localhost:39775/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39775/tests/kraken/driver.html?testName=ai-astar) 05:16:45 INFO - PROCESS | 9244 | RSS: Main: 160006144 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | __start_tp_report 05:16:45 INFO - PROCESS | 9244 | _x_x_mozilla_page_load 05:16:45 INFO - PROCESS | 9244 | _x_x_mozilla_page_load_details 05:16:45 INFO - PROCESS | 9244 | |i|pagename|runs| 05:16:45 INFO - PROCESS | 9244 | |0;ai-astar;103;112;113;110;111;111;111;112;111;111 05:16:45 INFO - PROCESS | 9244 | |1;audio-beat-detection;150;122;132;157;123;122;123;125;152;121 05:16:45 INFO - PROCESS | 9244 | |2;audio-dft;161;162;162;163;162;162;162;163;161;163 05:16:45 INFO - PROCESS | 9244 | |3;audio-fft;82;76;74;109;75;76;74;75;108;77 05:16:45 INFO - PROCESS | 9244 | |4;audio-oscillator;81;82;101;81;83;82;93;82;81;112 05:16:45 INFO - PROCESS | 9244 | |5;imaging-gaussian-blur;118;118;117;119;117;118;117;117;117;118 05:16:45 INFO - PROCESS | 9244 | |6;imaging-darkroom;146;148;147;147;147;148;147;146;147;147 05:16:45 INFO - PROCESS | 9244 | |7;imaging-desaturate;85;85;86;85;86;86;85;85;86;85 05:16:45 INFO - PROCESS | 9244 | |8;json-parse-financial;52;52;50;51;55;52;52;51;52;54 05:16:45 INFO - PROCESS | 9244 | |9;json-stringify-tinderbox;65;60;60;61;60;60;60;61;60;61 05:16:45 INFO - PROCESS | 9244 | |10;stanford-crypto-aes;75;75;74;73;74;74;75;74;73;74 05:16:45 INFO - PROCESS | 9244 | |11;stanford-crypto-ccm;129;137;136;126;125;135;131;133;165;141 05:16:45 INFO - PROCESS | 9244 | |12;stanford-crypto-pbkdf2;157;173;155;155;155;151;153;154;153;157 05:16:45 INFO - PROCESS | 9244 | |13;stanford-crypto-sha256-iterative;62;64;63;62;61;63;62;61;61;63 05:16:45 INFO - PROCESS | 9244 | __end_tp_report 05:16:45 INFO - PROCESS | 9244 | __start_cc_report 05:16:45 INFO - PROCESS | 9244 | _x_x_mozilla_cycle_collect,820 05:16:45 INFO - PROCESS | 9244 | __end_cc_report 05:16:45 INFO - PROCESS | 9244 | __startTimestamp1479475005265__endTimestamp 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | ------- Summary: start ------- 05:16:45 INFO - PROCESS | 9244 | Number of tests: 14 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 05:16:45 INFO - PROCESS | 9244 | Values: 103.0 112.0 113.0 110.0 111.0 111.0 111.0 112.0 111.0 111.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#1] audio-beat-detection Cycles:10 Average:132.70 Median:128.50 stddev:14.44 (11.2%) stddev-sans-first:13.89 05:16:45 INFO - PROCESS | 9244 | Values: 150.0 122.0 132.0 157.0 123.0 122.0 123.0 125.0 152.0 121.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:16:45 INFO - PROCESS | 9244 | Values: 161.0 162.0 162.0 163.0 162.0 162.0 162.0 163.0 161.0 163.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:13.84 (18.3%) stddev-sans-first:14.68 05:16:45 INFO - PROCESS | 9244 | Values: 82.0 76.0 74.0 109.0 75.0 76.0 74.0 75.0 108.0 77.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#4] audio-oscillator Cycles:10 Average:87.80 Median:82.00 stddev:10.80 (13.2%) stddev-sans-first:11.17 05:16:45 INFO - PROCESS | 9244 | Values: 81.0 82.0 101.0 81.0 83.0 82.0 93.0 82.0 81.0 112.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:16:45 INFO - PROCESS | 9244 | Values: 118.0 118.0 117.0 119.0 117.0 118.0 117.0 117.0 117.0 118.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 05:16:45 INFO - PROCESS | 9244 | Values: 146.0 148.0 147.0 147.0 147.0 148.0 147.0 146.0 147.0 147.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 05:16:45 INFO - PROCESS | 9244 | Values: 85.0 85.0 86.0 85.0 86.0 86.0 85.0 85.0 86.0 85.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.00 stddev:1.45 (2.8%) stddev-sans-first:1.54 05:16:45 INFO - PROCESS | 9244 | Values: 52.0 52.0 50.0 51.0 55.0 52.0 52.0 51.0 52.0 54.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:60.50 stddev:1.55 (2.6%) stddev-sans-first:0.50 05:16:45 INFO - PROCESS | 9244 | Values: 65.0 60.0 60.0 61.0 60.0 60.0 60.0 61.0 60.0 61.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:0.74 (1.0%) stddev-sans-first:0.71 05:16:45 INFO - PROCESS | 9244 | Values: 75.0 75.0 74.0 73.0 74.0 74.0 75.0 74.0 73.0 74.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:135.50 stddev:11.41 (8.4%) stddev-sans-first:11.83 05:16:45 INFO - PROCESS | 9244 | Values: 129.0 137.0 136.0 126.0 125.0 135.0 131.0 133.0 165.0 141.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:155.00 stddev:6.15 (4.0%) stddev-sans-first:6.51 05:16:45 INFO - PROCESS | 9244 | Values: 157.0 173.0 155.0 155.0 155.0 151.0 153.0 154.0 153.0 157.0 05:16:45 INFO - PROCESS | 9244 | 05:16:45 INFO - PROCESS | 9244 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.50 stddev:1.03 (1.7%) stddev-sans-first:1.09 05:16:45 INFO - PROCESS | 9244 | Values: 62.0 64.0 63.0 62.0 61.0 63.0 62.0 61.0 61.0 63.0 05:16:45 INFO - PROCESS | 9244 | -------- Summary: end -------- 05:16:45 INFO - PROCESS | 9244 | 05:16:46 INFO - TEST-INFO | 9244: exit 0 05:16:46 INFO - TEST-OK | kraken | took 60541ms 05:16:46 INFO - SUITE-END | took 1173s 05:16:46 INFO - Completed test suite (00:19:33) 05:16:46 INFO - javascript benchmark 05:16:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.61021402381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3166.9524957125645, 3190.6968837960385, 3215.0837011451736, 3225.483922572389, 3244.789088709232, 5585.636933599313, 5602.943970560294, 5604.131359639252, 5609.551235901128, 5620.353659329178, 5524.088525393306, 5596.300462442195, 5604.551635869131, 5626.099824028156, 5635.380108188096, 5080.898382032357, 5116.846494605168, 5165.070287348276, 5198.0383629028565, 5198.168293073109, 5096.133657278272, 5167.173252279636, 5178.741062946838, 5180.974095129519, 5186.7147306898105, 4966.205407134859, 4969.304297398367, 5179.663321884084, 5185.092608793446, 5193.272941788153, 5050.949490505103, 5059.671121377117, 5084.237364395333, 5115.846524604268, 5163.457836927144, 5012.77442515084, 5089.287499750038, 5105.310783044279, 5118.59051275897, 5128.282040514331, 5362.088444964365, 5485.314335708036, 5514.6691198528215, 5586.217929489874, 5593.468620481089, 5798.072308430631, 5823.039198532279, 5838.124281357788, 5908.231929849092, 5920.0, 5873.324567674729, 5888.941110588882, 5892.145638882381, 5955.791547295824, 5979.730912108966, 5564.749586268668, 5566.749496272637, 5568.9443105569235, 5578.358488773762, 5579.469950354791, 5999.100134979701, 6037.305709843336, 6062.605930614496, 6064.332923378425, 6096.329403765582, 5801.158831969341, 5832.125181222766, 5855.443732845373, 5856.882862342729, 5870.0, 5742.3396309424115, 5778.855528611734, 5875.0, 5905.527557795366, 5914.9112763308585, 5817.127430885401, 5861.267341582302, 5926.436988486087, 5934.109883517421, 6007.459328660441, 5928.555358348055, 5949.345571987078, 5953.464188223081, 5953.821385358447, 5970.611910225822, 4434.179676759745, 4609.216433206363, 4636.698614590041, 4638.907221855611, 4642.3500709900645, 4043.9191216175514, 4053.756774593534, 4081.387791831249, 4099.959000409957, 4109.712320137622, 5635.154726791015, 5646.57650676201, 5692.260006199168, 5693.601447898607, 5703.7433315500075, 5851.561132915049, 5932.851678708067, 5947.762089516371, 5949.345571987078, 5963.970180149158, 5583.246261754611, 5605.103183490622, 5632.04255276604, 5635.957347890653, 5638.069718496484, 5065.037642847848, 5068.0, 5088.185890257541, 5101.642884998015, 5109.56568691658, 6153.292371377349, 6166.383361663798, 6187.0, 6190.2571691397325, 6195.845103872439, 5746.712664366682, 5789.2184555086205, 5918.378570250234, 5922.378150294157, 5943.435373639497, 6193.535484838565, 6202.255729312511, 6205.81382558524, 6212.596181248205, 6213.099100630474, 5794.246747922743, 5810.622309549865, 5843.152742852348, 5851.824445266649, 5867.442592953663, 5847.619904706181, 5873.911891321548, 5878.500327472213, 5908.970455147869, 5916.437938395846, 5782.884342313214, 5786.710664466844, 5787.826365209051, 5788.305403351625, 5795.1017592273265, 5771.422857714363, 5778.422157784188, 5800.854978625568, 5814.447627475383, 5864.149698293809, 5699.743511542073, 5737.627054241628, 5760.884782304414, 5765.365809760839, 5773.884522309614, 5798.217240672455, 5808.361080281081, 5821.505172060253, 5882.323532793784, 5886.087656413263, 5559.52744016747, 5615.129654903497, 5726.828195154152, 5744.971275143597, 5760.510356619734], "value": 5482.726903397566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.812127937141, 625.3590070178068, 644.7711062572785, 655.8819412505753, 673.5117040145894, 45666.77166614166, 46973.999999999956, 47034.0, 50007.74996125014, 50109.0, 46266.768666156706, 46796.53203467964, 46803.29795053069, 46956.0, 47027.76486117573, 8728.43265187764, 8863.069377715343, 8876.423032502867, 8877.289816814638, 8919.24186444153, 8701.43440676354, 8758.167974042455, 8765.474071555727, 8767.079456657055, 8829.249513791336, 8771.16673915977, 8828.602712877904, 8843.115688431137, 8854.822903541924, 8869.512176830272, 8792.736217913473, 8811.427257228259, 8824.514651694155, 8842.646294148259, 8869.645214191425, 8687.826243475096, 8751.737447876574, 8802.515861627608, 8831.02858685544, 8843.33674974373, 44685.55314446847, 44969.325460118125, 45175.548244517464, 45220.54779452229, 45237.32144017842, 3634.6728794408364, 3776.3202623527754, 3822.57951625321, 3825.08198032473, 4121.732087414309, 33347.0, 33450.163745906306, 33599.664003359896, 33786.662133378595, 33792.49311260333, 4366.3013917773005, 4378.452693413324, 4401.097774956158, 4478.171538265431, 4493.438320209973, 362842.0, 364863.0, 366477.0, 366894.0, 368123.0, 64956.67521662456, 65525.67237163784, 65616.34383656198, 65627.67186164134, 65761.67119164373, 68072.0, 68328.31671683319, 68412.0, 68459.31540684629, 68797.3120268791, 17922.5519362017, 17948.55128621795, 18043.729344059848, 18130.546736331435, 18169.182386792363, 14632.122072675673, 14707.705845883236, 14733.189674568002, 14799.408023678932, 14832.406703731946, 18413.820571542314, 19211.0, 19457.28543409706, 19466.70799938002, 19555.413337599894, 6519.739210431624, 6695.1965764107645, 6703.195616526048, 6742.730290788313, 6810.318968103249, 954.0221273194892, 1049.1187402581868, 1073.92070968676, 1079.9568017279378, 1166.5333866453486, 33080.0, 33100.83449582737, 33148.834255829046, 33154.5026824593, 33272.83363583215, 1061.8850207282323, 1080.9297395669257, 1105.8009558279425, 1160.4545863444168, 1245.7383949370553, 16620.036078657522, 17141.22864471077, 17172.65654686899, 17228.62171026315, 17295.0, 484810.0, 486113.0, 486318.0, 488912.0, 493472.0, 62589.687051565365, 62594.68702656458, 62783.74432511324, 62807.0, 62980.37019629837, 1410.7108042851191, 1414.8019277301187, 1422.6087825847974, 1447.1244896837684, 1457.8031965684497, 31473.8426307867, 31975.36049278955, 32394.0, 32638.83680581582, 32986.0, 53879.0, 53912.73043634757, 54141.729291353295, 54317.0, 54348.456515434336, 437009.0, 437650.0, 439549.0, 439903.0, 442047.0, 44451.55548444474, 44956.0, 44962.77518612386, 45328.54671453243, 45543.31685024661, 51204.74397627988, 51704.0, 52231.21653175129, 52422.47577524176, 53171.202431962774, 42933.92665183396, 43148.92127696833, 44395.0, 44476.0, 45617.77191114023, 42394.1521169581, 43440.0, 44143.33784993163, 44166.84415693742, 44256.557434425245, 37667.81166094152, 38041.42937855879, 43792.78103609462, 45295.773521132185, 46562.06875862532, 44167.33748993703, 45579.316310256036, 45830.0, 47057.2941405886, 47332.763336183096, 35108.824455877555, 35362.0, 35470.822645886605, 35554.28891422209, 35564.466533002545], "value": 21395.840511224756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.7527046137085, 424.2840207150433, 427.7262551966742, 432.94371731674886, 434.79564604635823, 18528.90735546322, 19494.0, 19885.403437896868, 19895.303664371713, 20132.194712211513, 19683.803161968375, 20036.797792132482, 20476.590468190665, 20523.38429847103, 20733.274335398262, 5700.572457065716, 6018.15745795589, 6034.034554471264, 6039.335673075958, 6047.546434017444, 4475.709078909877, 5885.411458854123, 5979.1330257112695, 6680.83297917551, 6741.426978706816, 6742.190937087532, 6794.660266986655, 6827.897581536281, 6837.453003759687, 6837.623930683811, 5698.8290351289525, 5851.0, 5936.376680448577, 5960.582759206835, 6032.698365081728, 5660.773569057233, 5815.691469419389, 5831.096180092092, 5869.1196320551835, 5881.676622759887, 14589.854101459061, 14758.63103422423, 14868.925655371762, 15053.397864085424, 15149.545513634608, 2298.287530865437, 2330.2077293720217, 2855.6858745537975, 2941.58817765513, 3066.402051599939, 11334.093272538259, 11566.653000409917, 12061.698457538632, 12151.0, 15519.379224830993, 1911.3119277060248, 2045.8016786320181, 2046.7953204679413, 2068.493219161315, 2076.1384025629345, 84554.0, 84875.57562212211, 87971.56014219952, 88051.11948880494, 88093.55953220258, 11957.162998590014, 11969.700757481132, 12017.699557511132, 12185.573504927284, 12409.317487538272, 17343.39298124585, 17421.82578174202, 17427.825721742873, 17478.563035924202, 17487.562810929576, 8467.449615774955, 8552.786180345542, 8663.306935445149, 8773.034966153718, 8788.648454061893, 7998.360131189491, 8163.224899518883, 8187.549684767276, 8246.257836794717, 8312.625931832961, 5150.098732721759, 5162.3030890830005, 5206.609504287194, 5234.947650523446, 5320.920186197211, 1780.946571602854, 1858.87917285376, 1900.116445852685, 1997.2809788476136, 2000.1299434745931, 881.3037700216757, 984.3945973226414, 1002.7092143278368, 1051.6687243518268, 1056.3345092591771, 19521.414357569294, 20064.69902951457, 20084.799152008294, 20213.797862021485, 20365.08357123933, 984.8473486609587, 1013.8331457708811, 1028.665683652816, 1039.6776999130293, 1041.8801837788599, 10638.255322127377, 11187.386730704897, 11241.381724005258, 11257.043151332065, 11277.436128193558, 508432.0, 514112.0, 515334.0, 519264.0, 525086.0, 89722.0, 89875.0, 89876.0, 92944.0, 95276.52361738146, 1046.529061922138, 1085.4355735017746, 1088.613542192526, 1090.0407641275626, 1104.4422566603814, 17465.82534174642, 17477.55032769736, 17717.29130834752, 17741.822581774533, 18101.637967240844, 42211.36682949697, 42407.0, 43299.13401732011, 43528.34707479454, 44291.89270268269, 54551.45448545464, 57090.42909570851, 58084.709576451845, 58556.12165817431, 62048.68975655093, 8029.3175080118845, 8373.66505339804, 8384.53885036329, 8630.78423039429, 8635.740927772176, 9818.067283608047, 13273.137246078973, 13840.909884867298, 13846.376913038735, 14008.369623367176, 12230.715774843513, 12528.87471125277, 12642.494300227889, 12670.746585068062, 12786.872131278567, 11579.478923448296, 11710.355930423908, 11786.469608867794, 12183.0, 12597.496100156257, 12705.301208433624, 12770.16993895431, 12782.296973666538, 13154.0, 13222.867771322164, 8307.792305192419, 8415.0, 8581.442206256574, 8662.04717481064, 8678.045415004472, 11915.463804128662, 12044.156909016636, 12158.574449894211, 12208.633740987785, 12798.360081996048], "value": 9577.09627830931, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.9247537623116, 1535.9846401535985, 1689.3833750681006, 1811.9762334281138, 1825.7261410788387, 7684.692612295516, 7873.566953817538, 8129.187081291875, 8669.69656062038, 8679.349048821332, 8136.674533018687, 8333.125021872707, 8348.791280217982, 8548.187922147401, 8603.827923441528, 2457.6067829147387, 2488.5271798358253, 2500.962485562718, 2504.0860086068546, 2510.435152090774, 2470.2465747946867, 2533.1513942829174, 2534.3917459809695, 2538.6953565572157, 2543.135333986444, 2423.3941514621347, 2446.4617784087563, 2474.40614252579, 2479.2562231330617, 2481.1688084491716, 2394.5330660521117, 2410.915617953372, 2424.284835973392, 2427.6965379327585, 2443.8289319747623, 2361.6221404575185, 2372.774586414288, 2389.235444657693, 2391.485830546441, 2416.395901024744, 8453.323734101257, 8496.235338819473, 8587.055423903366, 8599.61301741423, 8622.698205562838, 5098.59211263098, 5229.058769421503, 5234.057869583474, 5271.683698978073, 5330.813421530228, 3503.1417302760733, 3566.3045706087323, 3585.4621806728937, 3592.4431713084514, 3710.962890371116, 1227.9631611051682, 1240.8448943882015, 1271.7520083583704, 1295.7408518296284, 1311.645855618987, 11398.316101033965, 11486.712832179179, 11502.194846360759, 11507.769844603145, 11615.76768464626, 4638.489766125724, 4652.418447694038, 4725.9054818904115, 4747.86051347674, 4768.9523104769205, 9265.675701350421, 9349.90650093504, 9362.344635875423, 9365.578548965314, 9378.109079637423, 5208.401033881152, 5224.52979231871, 5237.659552129099, 5238.135707608279, 5253.789848406097, 4774.737389443544, 4848.00615873745, 4907.141250281186, 4911.607071434277, 4944.357233559686, 3738.6261373862394, 3802.733808633369, 3819.579846216914, 3853.190829925691, 3882.1265215326325, 1212.0969877441362, 1212.7695737809788, 1214.6598952293373, 1221.7922953097996, 1222.957196498136, 987.6592575561419, 996.9351992120634, 1013.1489548779061, 1015.167562598662, 1038.050184081572, 5652.18043383707, 5686.289213848269, 5753.252077229933, 5899.410058994066, 5939.792107276225, 496.9850904472872, 499.86003918902765, 504.92678561608363, 508.51182864449805, 515.8246196293203, 3766.246750649881, 4078.7552746835286, 4165.562615925345, 4172.687048471377, 4243.978780106141, 10256.487175641189, 10563.841542376716, 10614.840777388345, 10646.095081917969, 10689.144868410509, 9926.553305101143, 10461.215408844368, 10509.579616815394, 10516.842247366296, 10582.994615511514, 7694.0767107946285, 8099.757007289791, 8101.392395570356, 8115.594220288962, 8163.551004694798, 5558.194061861089, 5567.860803479945, 5580.609357344947, 5606.943930560642, 5619.325680918152, 9623.903760962301, 9637.37357071788, 9704.563294651616, 9770.0, 9803.0, 9253.491057991605, 9468.242540596873, 9525.380850244712, 9707.077827606367, 9722.562484688347, 7929.365650748042, 8012.919870801217, 8098.75703728889, 8174.386920980831, 8369.079401265977, 8453.239208471266, 8472.83054338922, 8496.300739851931, 8569.828603427772, 8581.098984606526, 7504.512206706547, 7554.697812087455, 7617.124030736536, 7643.312101910855, 7912.881306780288, 7125.857482850418, 7227.349538541556, 7394.038774959221, 7403.259674032769, 7541.321281084729, 6765.458763299022, 6778.0, 6791.93208067913, 6933.064036355229, 6958.095447591781, 4828.686135401188, 4869.537393947569, 4889.706617602955, 4980.576650984707, 5052.343195384577, 5086.720230387365, 5121.539061484485, 5215.113430716711, 5234.13636749932, 5363.490468405495], "value": 4546.323777819232, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.56255399473656, 357.4691582999246, 359.23482981249924, 360.40353215428473, 361.86249225294387, 5500.504954554094, 5602.0, 5602.299712535933, 5626.046325679021, 5643.153526970957, 5547.750351234194, 5550.47270509302, 5565.3878073412, 5597.272354593907, 5600.943990560093, 4277.786110694468, 4321.589449002356, 4373.059792144688, 4391.451068616423, 4420.823167073313, 4349.7390156590545, 4367.323064924942, 4378.5183629800695, 4382.5398333175035, 4383.189110014641, 4301.225779359714, 4341.023269764293, 4341.826326946918, 4344.087741574273, 4350.021245219816, 4164.1255336379545, 4340.305551111823, 4352.303631418989, 4375.584319489643, 4393.472783266028, 3893.143508428141, 3897.337452633059, 3906.9609303907164, 3909.8240579174008, 3960.1089754805225, 5440.972795135999, 5477.014137455257, 5489.752961116759, 5546.417626149277, 5560.525566123077, 4885.658003939726, 5044.873878153039, 5044.949550504484, 5056.84829455117, 5090.898182036339, 5845.678487683176, 5849.151872978437, 5854.151148083547, 5856.62369343204, 5859.501942334907, 4310.224159651261, 4326.221280169569, 4328.870133895956, 4341.934870976938, 4346.782660866944, 5752.309722833245, 5931.4661680448535, 6010.265329275213, 6100.359462256488, 6122.510199184099, 4275.0, 4290.442242508454, 4305.763183024901, 4306.0, 4321.827126914951, 4372.956270437255, 4392.209402307615, 4396.340548917624, 4404.810701110682, 4419.690621656518, 4915.18899381598, 4983.9252411213865, 4988.700677959334, 4994.375703037121, 5008.949910500848, 5804.622699524517, 5825.359210486843, 5849.327327357409, 5854.648721076749, 5864.179014937912, 1481.82935480971, 1514.1899083990234, 1515.9393624255126, 1516.8938174327911, 1521.8890210146656, 1008.8839783425, 1056.615833258434, 1066.248294952057, 1076.5424694504804, 1087.4671411008549, 5473.151661492475, 5514.773857293529, 5538.47384498472, 5601.383847776741, 5642.376295022834, 5871.6770577618645, 5875.0, 5904.498117659961, 5916.0, 5918.822435326947, 5293.173855020012, 5349.732513374316, 5491.862703432366, 5535.667859928417, 5606.747696353674, 3040.528718048706, 3048.192229059301, 3055.343101233201, 3062.892798752033, 3091.8144911305394, 5800.651960882361, 6005.369436209223, 6035.366286539938, 6041.516678665696, 6066.908996365058, 5774.855628609234, 5845.853853653608, 5846.356900740915, 5847.853803654943, 5867.794627188028, 6009.45914867664, 6033.698315084228, 6038.305594856648, 6072.544559158081, 6086.330503644595, 5636.577256705681, 5691.345495267931, 5727.055035919193, 5727.427257274406, 5766.3368712598585, 5665.518430933417, 5682.119271512922, 5707.886962042528, 5721.914171287351, 5751.626144300774, 6072.544559158169, 6088.847778805565, 6255.186825712628, 6305.211848518935, 6316.873662526816, 4364.38898554209, 4377.365282034151, 4396.4064851244675, 4400.92177416535, 4421.447319085114, 5954.19618351517, 6064.4995503020655, 6081.817545473643, 6142.232220972379, 6157.445829875153, 5862.530997520274, 5865.648061116347, 5875.618084824473, 5880.735366908414, 5923.911141332969, 5864.501517370901, 5903.350631430453, 5916.852078698067, 5917.319508256605, 5930.466258036798, 5649.830505084854, 5760.8271751847515, 5790.826275211751, 5791.681457519709, 5844.2986841577585, 5872.941270587239, 5882.735276912464, 5955.315138759098, 5956.285245770535, 5958.7616495341435, 5606.271184745957, 5662.320521537442, 5732.914006289992, 5795.913061304, 5811.331696854916], "value": 4463.392005179787, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.7844603511018, 787.7715462515871, 830.5556527257918, 879.4020066354876, 905.2531661379363, 15390.538283851489, 15975.520734377973, 16133.43532976346, 16192.35230590778, 16245.756313655274, 14532.636684082876, 14549.709005819877, 15481.0, 16290.674186516262, 16319.51041468755, 834.845553572588, 858.3433673239945, 860.0797147052656, 860.389123722158, 864.6454953469079, 844.2317491083115, 850.0606829453458, 850.2475309351207, 850.8468475674376, 850.8978922529305, 892.4912799704172, 893.8882639670041, 894.5482531321674, 894.8702438146465, 897.0222457521301, 891.38494438837, 891.4829398948594, 894.2890402130322, 895.1138373010738, 896.318797713739, 652.2466551133449, 652.6280020388381, 652.6704014472708, 653.137858027404, 655.8032590222962, 15459.61350966235, 15480.071195728293, 15495.070295782176, 15521.534353969399, 15613.297401616954, 14490.058146220568, 14883.0, 14958.47645332419, 15015.474458394014, 15053.623854127165, 11308.491117899714, 11507.482163302671, 11603.477843497063, 11688.883111168865, 11863.644090677293, 3774.3960966245545, 3789.905252368685, 3806.2663289523553, 3806.505154329947, 3901.0247438140464, 68636.68765297349, 70295.29704702938, 70560.29439705588, 70784.0, 72529.63735181344, 10582.115727607466, 10627.309224900511, 10821.0, 10835.0, 10925.836112458319, 19491.512712182026, 19506.0, 19510.122044508033, 19515.0, 19533.0, 7729.420293478011, 7998.960135182389, 8153.959230203811, 8243.422960392834, 8313.958430207811, 4587.7017993830295, 4681.625469962395, 4800.399950006249, 4828.396450443694, 4830.782614782343, 3337.5828021497314, 3440.071180781175, 3445.0, 3463.3939060664284, 3486.877959271413, 619.1826788638954, 628.1237673445518, 634.4765568406084, 635.6186288227027, 636.4431122767578, 718.4647437658978, 730.2332550821616, 736.8820988641899, 746.7834328044914, 765.59806101797, 9775.217982561378, 9862.0, 9898.158656514133, 9934.155596774355, 10576.947115264375, 656.7832615236961, 712.4478529139958, 737.4616529933072, 742.1354122447397, 750.0961341583379, 4329.631981281564, 4488.192125417456, 4551.271796512542, 4623.722576645412, 4629.629629629621, 55325.72337138288, 55935.44064559384, 55977.0, 76834.84747728788, 79484.0, 53701.731491343075, 63923.0, 65041.34958650353, 80504.0, 81030.0, 42868.14263714771, 42928.35607465891, 55586.44413555894, 64776.0, 65819.0, 9398.389104708172, 9940.304178707422, 10158.746031349276, 10501.579936802747, 10563.841542376716, 44801.55198447974, 46618.300725488465, 47158.0, 47460.28809567928, 48443.0, 65602.34397655963, 66533.66733166497, 67106.66446667735, 67230.0, 67795.0, 12395.62813115608, 12869.163504372185, 12952.935235323763, 13112.672183195114, 13441.932790335986, 13423.932880335537, 13540.255285958972, 13932.651683707989, 14102.435902564193, 14591.197484138474, 12928.482860685843, 13082.672933176747, 13136.868631313564, 13221.140625859289, 13236.66908327261, 13633.659158521117, 13657.931710341782, 13684.0, 13725.588232353046, 13772.24252666113, 13080.345982701017, 13089.672758181121, 13197.604071877859, 13388.464461421434, 13566.118202316818, 11134.27627204229, 11181.776364472502, 11300.547978080785, 11773.0, 12241.449134789134, 11364.715882103013, 11722.062235021349, 11821.881781182077, 11823.704407389883, 11890.28658280506], "value": 7276.054450889536, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1466.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 110.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 132.0, 157.0, 123.0, 122.0, 123.0, 125.0, 152.0, 121.0], "value": 132.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 163.0, 162.0, 162.0, 162.0, 163.0, 161.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 74.0, 109.0, 75.0, 76.0, 74.0, 75.0, 108.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 101.0, 81.0, 83.0, 82.0, 93.0, 82.0, 81.0, 112.0], "value": 87.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 85.0, 86.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 50.0, 51.0, 55.0, 52.0, 52.0, 51.0, 52.0, 54.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 73.0, 74.0, 74.0, 75.0, 74.0, 73.0, 74.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 137.0, 136.0, 126.0, 125.0, 135.0, 131.0, 133.0, 165.0, 141.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 173.0, 155.0, 155.0, 155.0, 151.0, 153.0, 154.0, 153.0, 157.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 62.0, 61.0, 63.0, 62.0, 61.0, 61.0, 63.0], "value": 62.2, "unit": "score"}]}]} 05:16:46 INFO - Return code: 0 05:16:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:16:46 ERROR - # TBPL SUCCESS # 05:16:46 INFO - Running post-action listener: _resource_record_post_action 05:16:46 INFO - [mozharness: 2016-11-18 13:16:46.564994Z] Finished run-tests step (success) 05:16:46 INFO - Running post-run listener: _resource_record_post_run 05:16:46 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 355508224; Read time: 32; Write time: 263644 05:16:46 INFO - TinderboxPrint: CPU usage
13.3% 05:16:46 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 05:16:46 INFO - TinderboxPrint: I/O write bytes / time
355,508,224 / 263,644 05:16:46 INFO - TinderboxPrint: CPU idle
8,221.0 (86.7%) 05:16:46 INFO - TinderboxPrint: CPU user
1,207.4 (12.7%) 05:16:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:16:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108109824; Read time: 0; Write time: 124352 05:16:46 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247029760; Read time: 20; Write time: 139292 05:16:47 INFO - Running post-run listener: _upload_blobber_files 05:16:47 INFO - Blob upload gear active. 05:16:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:16:47 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 05:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:16:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:16:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:48 INFO - (blobuploader) - INFO - Done attempting. 05:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:49 INFO - (blobuploader) - INFO - Done attempting. 05:16:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:16:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:16:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:52 INFO - (blobuploader) - INFO - Done attempting. 05:16:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:52 INFO - Return code: 0 05:16:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:16:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/091cddd439cf3f9106bb663f8a93076f9a110dc9e6a2a47feb5509a2f3f4571675447d0d8e284038154503a728eaf8519437816c33f42721f2b1b10249aeabf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de07865fc0f45aab10d4dc1382512996f5c43d5b2d398bce8440aa0e5326702c5f2608a3d546ee7bfb61f79a86343be5f611a325b44fd8e58f7fa80bd88d0ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ed8de9e4cbd492f4566cfda80e4bf10fb050aba2b7d218951aa31cdeb456371d86dd206bccbb7ca5b60cd4be2777b24338f048136799d7026be76a964cf88ad"} 05:16:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:16:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:16:52 INFO - Contents: 05:16:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/091cddd439cf3f9106bb663f8a93076f9a110dc9e6a2a47feb5509a2f3f4571675447d0d8e284038154503a728eaf8519437816c33f42721f2b1b10249aeabf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de07865fc0f45aab10d4dc1382512996f5c43d5b2d398bce8440aa0e5326702c5f2608a3d546ee7bfb61f79a86343be5f611a325b44fd8e58f7fa80bd88d0ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ed8de9e4cbd492f4566cfda80e4bf10fb050aba2b7d218951aa31cdeb456371d86dd206bccbb7ca5b60cd4be2777b24338f048136799d7026be76a964cf88ad"} 05:16:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:16:52 INFO - Copying logs to upload dir... 05:16:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:16:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.318718 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-18 05:16:52.548437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 05:16:52.551541) ========= 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=c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/091cddd439cf3f9106bb663f8a93076f9a110dc9e6a2a47feb5509a2f3f4571675447d0d8e284038154503a728eaf8519437816c33f42721f2b1b10249aeabf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de07865fc0f45aab10d4dc1382512996f5c43d5b2d398bce8440aa0e5326702c5f2608a3d546ee7bfb61f79a86343be5f611a325b44fd8e58f7fa80bd88d0ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ed8de9e4cbd492f4566cfda80e4bf10fb050aba2b7d218951aa31cdeb456371d86dd206bccbb7ca5b60cd4be2777b24338f048136799d7026be76a964cf88ad"} build_url:https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/Vc8uPG6KRRyuiIIe0RnP6A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/091cddd439cf3f9106bb663f8a93076f9a110dc9e6a2a47feb5509a2f3f4571675447d0d8e284038154503a728eaf8519437816c33f42721f2b1b10249aeabf6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/de07865fc0f45aab10d4dc1382512996f5c43d5b2d398bce8440aa0e5326702c5f2608a3d546ee7bfb61f79a86343be5f611a325b44fd8e58f7fa80bd88d0ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5ed8de9e4cbd492f4566cfda80e4bf10fb050aba2b7d218951aa31cdeb456371d86dd206bccbb7ca5b60cd4be2777b24338f048136799d7026be76a964cf88ad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 05:16:52.577705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:16:52.578078) ========= 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=c6927cf182745ad25b1d38b9000001fe-1479470353.586351-364486050 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.85 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:16:53.437460) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 05:16:53.437762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 05:16:53.438272) ========= ========= Total master_lag: 0.96 =========