builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1479230472.64 results: success (0) buildid: 20161115063600 builduid: 843cb3c262754fdea6505e48af4f6961 revision: b7d42c3980d12dff16df9f6077f34279aeef49d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.641505) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.642180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.642634) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.667402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.667845) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 09:21:13-- 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% 37.2M=0s 2016-11-15 09:21:13 (37.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.158761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.841608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.842047) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014622 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.892683) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:12.893147) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b7d42c3980d12dff16df9f6077f34279aeef49d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b7d42c3980d12dff16df9f6077f34279aeef49d6 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 09:21:13,427 truncating revision to first 12 chars 2016-11-15 09:21:13,427 Setting DEBUG logging. 2016-11-15 09:21:13,427 attempt 1/10 2016-11-15 09:21:13,428 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b7d42c3980d1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 09:21:13,728 unpacking tar archive at: mozilla-inbound-b7d42c3980d1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:13.551617) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:13.551933) ========= script_repo_revision: b7d42c3980d12dff16df9f6077f34279aeef49d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:13.552439) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:13.552743) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 09:21:13.561965) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-15 09:21:13.562357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:21:14 INFO - MultiFileLogger online at 20161115 09:21:14 in /builds/slave/test 09:21:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 09:21:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:21:14 INFO - {'append_to_log': False, 09:21:14 INFO - 'base_work_dir': '/builds/slave/test', 09:21:14 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 09:21:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:21:14 INFO - 'branch': 'Mozilla-Inbound', 09:21:14 INFO - 'buildbot_json_path': 'buildprops.json', 09:21:14 INFO - 'config_files': ('talos/linux_config.py',), 09:21:14 INFO - 'default_actions': ('clobber', 09:21:14 INFO - 'read-buildbot-config', 09:21:14 INFO - 'download-and-extract', 09:21:14 INFO - 'populate-webroot', 09:21:14 INFO - 'create-virtualenv', 09:21:14 INFO - 'install', 09:21:14 INFO - 'run-tests'), 09:21:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:21:14 INFO - 'download_minidump_stackwalk': True, 09:21:14 INFO - 'download_symbols': 'ondemand', 09:21:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:21:14 INFO - 'tooltool.py': '/tools/tooltool.py', 09:21:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:21:14 INFO - '/tools/misc-python/virtualenv.py')}, 09:21:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:21:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:21:14 INFO - 'installer_path': 'installer.exe', 09:21:14 INFO - 'log_level': 'info', 09:21:14 INFO - 'log_name': 'talos', 09:21:14 INFO - 'log_to_console': True, 09:21:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:21:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:21:14 INFO - 'opt_config_files': (), 09:21:14 INFO - 'pip_index': False, 09:21:14 INFO - 'sps_profile': False, 09:21:14 INFO - 'sps_profile_interval': 0, 09:21:14 INFO - 'suite': 'dromaeojs-e10s', 09:21:14 INFO - 'system_bits': '32', 09:21:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:21:14 INFO - 'title': 'talos-linux64-ix-041', 09:21:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:21:14 INFO - 'use_talos_json': True, 09:21:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:21:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:21:14 INFO - 'work_dir': 'build'} 09:21:14 INFO - [mozharness: 2016-11-15 17:21:14.190994Z] Running clobber step. 09:21:14 INFO - Running pre-action listener: _resource_record_pre_action 09:21:14 INFO - Running main action method: clobber 09:21:14 INFO - rmtree: /builds/slave/test/build 09:21:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:21:15 INFO - Running post-action listener: _resource_record_post_action 09:21:15 INFO - [mozharness: 2016-11-15 17:21:15.167392Z] Finished clobber step (success) 09:21:15 INFO - [mozharness: 2016-11-15 17:21:15.167489Z] Running read-buildbot-config step. 09:21:15 INFO - Running pre-action listener: _resource_record_pre_action 09:21:15 INFO - Running main action method: read_buildbot_config 09:21:15 INFO - Using buildbot properties: 09:21:15 INFO - { 09:21:15 INFO - "project": "", 09:21:15 INFO - "product": "firefox", 09:21:15 INFO - "script_repo_revision": "production", 09:21:15 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 09:21:15 INFO - "repository": "", 09:21:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 09:21:15 INFO - "buildid": "20161115063600", 09:21:15 INFO - "pgo_build": "True", 09:21:15 INFO - "basedir": "/builds/slave/test", 09:21:15 INFO - "buildnumber": 2068, 09:21:15 INFO - "slavename": "talos-linux64-ix-041", 09:21:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:21:15 INFO - "platform": "ubuntu64_hw", 09:21:15 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 09:21:15 INFO - "branch": "mozilla-inbound", 09:21:15 INFO - "repo_path": "integration/mozilla-inbound", 09:21:15 INFO - "revision": "b7d42c3980d12dff16df9f6077f34279aeef49d6", 09:21:15 INFO - "stage_platform": "linux64-pgo", 09:21:15 INFO - "builduid": "843cb3c262754fdea6505e48af4f6961", 09:21:15 INFO - "slavebuilddir": "test" 09:21:15 INFO - } 09:21:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 09:21:15 INFO - Running post-action listener: _resource_record_post_action 09:21:15 INFO - [mozharness: 2016-11-15 17:21:15.169898Z] Finished read-buildbot-config step (success) 09:21:15 INFO - [mozharness: 2016-11-15 17:21:15.169985Z] Running download-and-extract step. 09:21:15 INFO - Running pre-action listener: _resource_record_pre_action 09:21:15 INFO - Running main action method: download_and_extract 09:21:15 INFO - mkdir: /builds/slave/test/build/tests 09:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:15 INFO - trying https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:21:15 INFO - Downloading https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:21:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:21:15 INFO - Downloaded 1361 bytes. 09:21:15 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 09:21:15 INFO - Using the following test package requirements: 09:21:15 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:15 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:21:15 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:21:15 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'jsshell-linux-x86_64.zip'], 09:21:15 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:21:15 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 09:21:15 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:21:15 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:21:15 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:21:15 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 09:21:15 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:21:15 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:21:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:21:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:15 INFO - Fetch https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:21:16 INFO - Http code: 200 09:21:16 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 09:21:16 INFO - x-amz-cf-id: vxKwdFuDzlGdzdiUoHthcA2bGnzSZpofjr6Rg2fEyhH0275mKLnXyA== 09:21:16 INFO - x-amz-version-id: NV5o.4Fiu6OSqSCxfS6cEzMaYbpO4zFE 09:21:16 INFO - Expected file size: 21976869 09:21:16 INFO - Obtained file size: 21976869 09:21:20 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:21:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 09:21:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:21:20 INFO - Fetch https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:21:21 INFO - Http code: 200 09:21:21 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 09:21:21 INFO - x-amz-cf-id: fUdQPlvdVP9m8EpuyUKLOQy-oD_tim6JVD-TzwA7QWAGnumxxPmBJA== 09:21:21 INFO - x-amz-version-id: NV5o.4Fiu6OSqSCxfS6cEzMaYbpO4zFE 09:21:21 INFO - Expected file size: 21976869 09:21:21 INFO - Obtained file size: 21976869 09:21:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 09:21:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:21:25 INFO - Fetch https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:21:26 INFO - Http code: 200 09:21:26 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 09:21:26 INFO - x-amz-cf-id: cUshaPGKfEazIVKgFOjJiiz2B3mJ2fKFo2P48nHHVaZQ8rVbv8oV2Q== 09:21:26 INFO - x-amz-version-id: sZ7XmSlZGhqpMrMursVY4s0iCfil8A8j 09:21:26 INFO - Expected file size: 14409038 09:21:26 INFO - Obtained file size: 14409038 09:21:26 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')]} 09:21:26 INFO - trying https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:26 INFO - Downloading https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:21:28 INFO - Downloaded 59569930 bytes. 09:21:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:28 INFO - mkdir: /builds/slave/test/properties 09:21:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:21:28 INFO - Writing to file /builds/slave/test/properties/build_url 09:21:28 INFO - Contents: 09:21:28 INFO - build_url:https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 09:21:29 INFO - Running post-action listener: _resource_record_post_action 09:21:29 INFO - Running post-action listener: set_extra_try_arguments 09:21:29 INFO - [mozharness: 2016-11-15 17:21:29.115644Z] Finished download-and-extract step (success) 09:21:29 INFO - [mozharness: 2016-11-15 17:21:29.115869Z] Running populate-webroot step. 09:21:29 INFO - Running pre-action listener: _resource_record_pre_action 09:21:29 INFO - Running main action method: populate_webroot 09:21:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:21:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:21:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:21:29 INFO - '--tppagecycles', 09:21:29 INFO - '7'], 09:21:29 INFO - 'tests': ['tsvgm']}}, 09:21:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:21:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:21:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:21:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:21:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:21:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['damp', 'tps']}, 09:21:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'tests': ['damp', 'tps']}, 09:21:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['dromaeo_dom']}, 09:21:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:21:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['basic_compositor_video']}, 09:21:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:21:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['a11yr', 09:21:29 INFO - 'ts_paint', 09:21:29 INFO - 'tpaint', 09:21:29 INFO - 'sessionrestore', 09:21:29 INFO - 'sessionrestore_no_auto_restore', 09:21:29 INFO - 'tabpaint']}, 09:21:29 INFO - 'other-e10s': {'tests': ['a11yr', 09:21:29 INFO - 'ts_paint', 09:21:29 INFO - 'tpaint', 09:21:29 INFO - 'sessionrestore', 09:21:29 INFO - 'sessionrestore_no_auto_restore', 09:21:29 INFO - 'tabpaint']}, 09:21:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:21:29 INFO - 'ts_paint', 09:21:29 INFO - 'tpaint', 09:21:29 INFO - 'sessionrestore', 09:21:29 INFO - 'sessionrestore_no_auto_restore', 09:21:29 INFO - 'tabpaint']}, 09:21:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:21:29 INFO - 'ts_paint', 09:21:29 INFO - 'tpaint', 09:21:29 INFO - 'sessionrestore', 09:21:29 INFO - 'sessionrestore_no_auto_restore', 09:21:29 INFO - 'tabpaint']}, 09:21:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['a11yr', 09:21:29 INFO - 'ts_paint', 09:21:29 INFO - 'tpaint', 09:21:29 INFO - 'sessionrestore', 09:21:29 INFO - 'sessionrestore_no_auto_restore', 09:21:29 INFO - 'tabpaint']}, 09:21:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['a11yr', 09:21:29 INFO - 'ts_paint', 09:21:29 INFO - 'tpaint', 09:21:29 INFO - 'sessionrestore', 09:21:29 INFO - 'sessionrestore_no_auto_restore', 09:21:29 INFO - 'tabpaint']}, 09:21:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['tsvgx', 09:21:29 INFO - 'tsvgr_opacity', 09:21:29 INFO - 'tart', 09:21:29 INFO - 'tscrollx', 09:21:29 INFO - 'cart']}, 09:21:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:21:29 INFO - 'tsvgr_opacity', 09:21:29 INFO - 'tart', 09:21:29 INFO - 'tscrollx', 09:21:29 INFO - 'cart']}, 09:21:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'talos_options': ['--disable-e10s'], 09:21:29 INFO - 'tests': ['tp5o']}, 09:21:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'tests': ['tp5o']}, 09:21:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'talos_options': ['--disable-e10s', 09:21:29 INFO - '--xperf_path', 09:21:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:29 INFO - 'tests': ['tp5n']}, 09:21:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:21:29 INFO - 'talos_options': ['--xperf_path', 09:21:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:21:29 INFO - 'tests': ['tp5n']}}, 09:21:29 INFO - 'talos.zip': {'path': '', 09:21:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:21:29 INFO - Running post-action listener: _resource_record_post_action 09:21:29 INFO - [mozharness: 2016-11-15 17:21:29.135097Z] Finished populate-webroot step (success) 09:21:29 INFO - [mozharness: 2016-11-15 17:21:29.135185Z] Running create-virtualenv step. 09:21:29 INFO - Running pre-action listener: _resource_record_pre_action 09:21:29 INFO - Running main action method: create_virtualenv 09:21:29 INFO - Creating virtualenv /builds/slave/test/build/venv 09:21:29 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 09:21:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:21:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:21:29 INFO - Using real prefix '/usr' 09:21:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:21:29 INFO - Installing distribute.............................................................................................................................................................................................done. 09:21:31 INFO - Installing pip.................done. 09:21:31 INFO - Return code: 0 09:21:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:21:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:21:31 INFO - Reading from file tmpfile_stdout 09:21:31 INFO - Output received: 09:21:31 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) 09:21:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:31 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:31 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 09:21:31 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 09:21:31 INFO - Using env: {'DISPLAY': ':0', 09:21:31 INFO - 'HOME': '/home/cltbld', 09:21:31 INFO - 'LANG': 'en_US.UTF-8', 09:21:31 INFO - 'LANGUAGE': 'en_US:en', 09:21:31 INFO - 'LOGNAME': 'cltbld', 09:21:31 INFO - 'MAIL': '/var/mail/cltbld', 09:21:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:31 INFO - 'MOZ_NO_REMOTE': '1', 09:21:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:31 INFO - 'NO_EM_RESTART': '1', 09:21:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:31 INFO - 'PWD': '/builds/slave/test', 09:21:31 INFO - 'SHELL': '/bin/bash', 09:21:31 INFO - 'SHLVL': '1', 09:21:31 INFO - 'TERM': 'linux', 09:21:31 INFO - 'TMOUT': '86400', 09:21:31 INFO - 'USER': 'cltbld', 09:21:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:31 INFO - '_': '/tools/buildbot/bin/python'} 09:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:32 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 09:21:32 INFO - Cleaning up... 09:21:32 INFO - Return code: 0 09:21:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:32 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:32 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 09:21:32 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 09:21:32 INFO - Using env: {'DISPLAY': ':0', 09:21:32 INFO - 'HOME': '/home/cltbld', 09:21:32 INFO - 'LANG': 'en_US.UTF-8', 09:21:32 INFO - 'LANGUAGE': 'en_US:en', 09:21:32 INFO - 'LOGNAME': 'cltbld', 09:21:32 INFO - 'MAIL': '/var/mail/cltbld', 09:21:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:32 INFO - 'MOZ_NO_REMOTE': '1', 09:21:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:32 INFO - 'NO_EM_RESTART': '1', 09:21:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:32 INFO - 'PWD': '/builds/slave/test', 09:21:32 INFO - 'SHELL': '/bin/bash', 09:21:32 INFO - 'SHLVL': '1', 09:21:32 INFO - 'TERM': 'linux', 09:21:32 INFO - 'TMOUT': '86400', 09:21:32 INFO - 'USER': 'cltbld', 09:21:32 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:32 INFO - '_': '/tools/buildbot/bin/python'} 09:21:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:32 INFO - Downloading/unpacking psutil>=3.1.1 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 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 09:21:32 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 09:21:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:34 INFO - Installing collected packages: psutil 09:21:34 INFO - Running setup.py install for psutil 09:21:34 INFO - building 'psutil._psutil_linux' extension 09:21:34 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 09:21:34 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 09:21:34 INFO - building 'psutil._psutil_posix' extension 09:21:34 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 09:21:34 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 09:21:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:21:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:21:34 INFO - Successfully installed psutil 09:21:34 INFO - Cleaning up... 09:21:34 INFO - Return code: 0 09:21:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:34 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:34 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 09:21:34 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 09:21:34 INFO - Using env: {'DISPLAY': ':0', 09:21:34 INFO - 'HOME': '/home/cltbld', 09:21:34 INFO - 'LANG': 'en_US.UTF-8', 09:21:34 INFO - 'LANGUAGE': 'en_US:en', 09:21:34 INFO - 'LOGNAME': 'cltbld', 09:21:34 INFO - 'MAIL': '/var/mail/cltbld', 09:21:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:34 INFO - 'MOZ_NO_REMOTE': '1', 09:21:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:34 INFO - 'NO_EM_RESTART': '1', 09:21:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:34 INFO - 'PWD': '/builds/slave/test', 09:21:34 INFO - 'SHELL': '/bin/bash', 09:21:34 INFO - 'SHLVL': '1', 09:21:34 INFO - 'TERM': 'linux', 09:21:34 INFO - 'TMOUT': '86400', 09:21:34 INFO - 'USER': 'cltbld', 09:21:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:34 INFO - '_': '/tools/buildbot/bin/python'} 09:21:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:21:35 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 09:21:35 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 09:21:35 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 09:21:35 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 09:21:35 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 09:21:35 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 09:21:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:21:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:21:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:21:37 INFO - Installing collected packages: mozsystemmonitor 09:21:37 INFO - Running setup.py install for mozsystemmonitor 09:21:37 INFO - Successfully installed mozsystemmonitor 09:21:37 INFO - Cleaning up... 09:21:37 INFO - Return code: 0 09:21:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:21:37 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')]} 09:21:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:37 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')]} 09:21:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:37 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:37 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 09:21:37 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 09:21:37 INFO - Using env: {'DISPLAY': ':0', 09:21:37 INFO - 'HOME': '/home/cltbld', 09:21:37 INFO - 'LANG': 'en_US.UTF-8', 09:21:37 INFO - 'LANGUAGE': 'en_US:en', 09:21:37 INFO - 'LOGNAME': 'cltbld', 09:21:37 INFO - 'MAIL': '/var/mail/cltbld', 09:21:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:37 INFO - 'MOZ_NO_REMOTE': '1', 09:21:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:37 INFO - 'NO_EM_RESTART': '1', 09:21:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:37 INFO - 'PWD': '/builds/slave/test', 09:21:37 INFO - 'SHELL': '/bin/bash', 09:21:37 INFO - 'SHLVL': '1', 09:21:37 INFO - 'TERM': 'linux', 09:21:37 INFO - 'TMOUT': '86400', 09:21:37 INFO - 'USER': 'cltbld', 09:21:37 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:37 INFO - '_': '/tools/buildbot/bin/python'} 09:21:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:37 INFO - Downloading/unpacking jsonschema==2.5.1 09:21:37 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 09:21:37 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 09:21:37 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 09:21:37 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 09:21:37 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 09:21:37 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 09:21:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:21:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:39 INFO - Downloading functools32-3.2.3-2.tar.gz 09:21:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:21:39 INFO - warning: no files found matching '*.txt' 09:21:39 INFO - no previously-included directories found matching 'build' 09:21:39 INFO - no previously-included directories found matching 'dist' 09:21:39 INFO - no previously-included directories found matching '.git*' 09:21:39 INFO - Installing collected packages: jsonschema, functools32 09:21:39 INFO - Running setup.py install for functools32 09:21:39 INFO - warning: no files found matching '*.txt' 09:21:39 INFO - no previously-included directories found matching 'build' 09:21:39 INFO - no previously-included directories found matching 'dist' 09:21:39 INFO - no previously-included directories found matching '.git*' 09:21:39 INFO - Successfully installed jsonschema functools32 09:21:39 INFO - Cleaning up... 09:21:39 INFO - Return code: 0 09:21:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:21: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')]} 09:21:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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')]} 09:21:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21: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', '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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:21: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 functools32==3.2.3-2 09:21:39 INFO - Using env: {'DISPLAY': ':0', 09:21:39 INFO - 'HOME': '/home/cltbld', 09:21:39 INFO - 'LANG': 'en_US.UTF-8', 09:21:39 INFO - 'LANGUAGE': 'en_US:en', 09:21:39 INFO - 'LOGNAME': 'cltbld', 09:21:39 INFO - 'MAIL': '/var/mail/cltbld', 09:21:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:39 INFO - 'MOZ_NO_REMOTE': '1', 09:21:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:39 INFO - 'NO_EM_RESTART': '1', 09:21:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:39 INFO - 'PWD': '/builds/slave/test', 09:21:39 INFO - 'SHELL': '/bin/bash', 09:21:39 INFO - 'SHLVL': '1', 09:21:39 INFO - 'TERM': 'linux', 09:21:39 INFO - 'TMOUT': '86400', 09:21:39 INFO - 'USER': 'cltbld', 09:21:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:39 INFO - '_': '/tools/buildbot/bin/python'} 09:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:21:40 INFO - Cleaning up... 09:21:40 INFO - Return code: 0 09:21:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:21:40 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')]} 09:21:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:40 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')]} 09:21:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:40 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:40 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 09:21:40 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 09:21:40 INFO - Using env: {'DISPLAY': ':0', 09:21:40 INFO - 'HOME': '/home/cltbld', 09:21:40 INFO - 'LANG': 'en_US.UTF-8', 09:21:40 INFO - 'LANGUAGE': 'en_US:en', 09:21:40 INFO - 'LOGNAME': 'cltbld', 09:21:40 INFO - 'MAIL': '/var/mail/cltbld', 09:21:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:40 INFO - 'MOZ_NO_REMOTE': '1', 09:21:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:40 INFO - 'NO_EM_RESTART': '1', 09:21:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:40 INFO - 'PWD': '/builds/slave/test', 09:21:40 INFO - 'SHELL': '/bin/bash', 09:21:40 INFO - 'SHLVL': '1', 09:21:40 INFO - 'TERM': 'linux', 09:21:40 INFO - 'TMOUT': '86400', 09:21:40 INFO - 'USER': 'cltbld', 09:21:40 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:40 INFO - '_': '/tools/buildbot/bin/python'} 09:21:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:40 INFO - Downloading/unpacking blobuploader==1.2.4 09:21:40 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 09:21:40 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 09:21:40 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 09:21:40 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 09:21:40 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 09:21:40 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 09:21:42 INFO - Downloading blobuploader-1.2.4.tar.gz 09:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:21:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:21:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:43 INFO - Downloading docopt-0.6.1.tar.gz 09:21:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:21:43 INFO - Installing collected packages: blobuploader, requests, docopt 09:21:43 INFO - Running setup.py install for blobuploader 09:21:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:21:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:21:43 INFO - Running setup.py install for requests 09:21:43 INFO - Running setup.py install for docopt 09:21:43 INFO - Successfully installed blobuploader requests docopt 09:21:43 INFO - Cleaning up... 09:21:43 INFO - Return code: 0 09:21:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:43 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')]} 09:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:43 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')]} 09:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:43 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:43 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 09:21:43 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 09:21:43 INFO - Using env: {'DISPLAY': ':0', 09:21:43 INFO - 'HOME': '/home/cltbld', 09:21:43 INFO - 'LANG': 'en_US.UTF-8', 09:21:43 INFO - 'LANGUAGE': 'en_US:en', 09:21:43 INFO - 'LOGNAME': 'cltbld', 09:21:43 INFO - 'MAIL': '/var/mail/cltbld', 09:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:43 INFO - 'MOZ_NO_REMOTE': '1', 09:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:43 INFO - 'NO_EM_RESTART': '1', 09:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:43 INFO - 'PWD': '/builds/slave/test', 09:21:43 INFO - 'SHELL': '/bin/bash', 09:21:43 INFO - 'SHLVL': '1', 09:21:43 INFO - 'TERM': 'linux', 09:21:43 INFO - 'TMOUT': '86400', 09:21:43 INFO - 'USER': 'cltbld', 09:21:43 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:43 INFO - '_': '/tools/buildbot/bin/python'} 09:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:43 INFO - Running setup.py (path:/tmp/pip-dHAyj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:43 INFO - Running setup.py (path:/tmp/pip-3CsrPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:44 INFO - Running setup.py (path:/tmp/pip-M4pZ6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:44 INFO - Running setup.py (path:/tmp/pip-DVrjxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:44 INFO - Running setup.py (path:/tmp/pip-Idfi93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:44 INFO - Running setup.py (path:/tmp/pip-nI2oSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:44 INFO - Running setup.py (path:/tmp/pip-utfo4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:44 INFO - Running setup.py (path:/tmp/pip-fdfQ8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:44 INFO - Running setup.py (path:/tmp/pip-MrsHmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:44 INFO - Running setup.py (path:/tmp/pip-zc6rHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:44 INFO - Running setup.py (path:/tmp/pip-4bOAka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:44 INFO - Running setup.py (path:/tmp/pip-oOCAGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:44 INFO - Running setup.py (path:/tmp/pip-S3Lh0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:44 INFO - Running setup.py (path:/tmp/pip-yFGnxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:44 INFO - Running setup.py (path:/tmp/pip-ov_Gsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:44 INFO - Running setup.py (path:/tmp/pip-IofAKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:45 INFO - Running setup.py (path:/tmp/pip-Jt2Diw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:21:45 INFO - Running setup.py install for manifestparser 09:21:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Running setup.py install for mozcrash 09:21:45 INFO - Running setup.py install for mozdebug 09:21:45 INFO - Running setup.py install for mozdevice 09:21:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Running setup.py install for mozfile 09:21:45 INFO - Running setup.py install for mozhttpd 09:21:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Running setup.py install for mozinfo 09:21:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Running setup.py install for mozInstall 09:21:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:21:45 INFO - Running setup.py install for mozleak 09:21:45 INFO - Running setup.py install for mozlog 09:21:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Running setup.py install for moznetwork 09:21:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Running setup.py install for mozprocess 09:21:46 INFO - Running setup.py install for mozprofile 09:21:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Running setup.py install for mozrunner 09:21:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Running setup.py install for mozscreenshot 09:21:46 INFO - Running setup.py install for moztest 09:21:46 INFO - Running setup.py install for mozversion 09:21:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:21:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:21:46 INFO - Cleaning up... 09:21:46 INFO - Return code: 0 09:21:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:46 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:46 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 09:21:46 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 09:21:46 INFO - Using env: {'DISPLAY': ':0', 09:21:46 INFO - 'HOME': '/home/cltbld', 09:21:46 INFO - 'LANG': 'en_US.UTF-8', 09:21:46 INFO - 'LANGUAGE': 'en_US:en', 09:21:46 INFO - 'LOGNAME': 'cltbld', 09:21:46 INFO - 'MAIL': '/var/mail/cltbld', 09:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:46 INFO - 'MOZ_NO_REMOTE': '1', 09:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:46 INFO - 'NO_EM_RESTART': '1', 09:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:46 INFO - 'PWD': '/builds/slave/test', 09:21:46 INFO - 'SHELL': '/bin/bash', 09:21:46 INFO - 'SHLVL': '1', 09:21:46 INFO - 'TERM': 'linux', 09:21:46 INFO - 'TMOUT': '86400', 09:21:46 INFO - 'USER': 'cltbld', 09:21:46 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:46 INFO - '_': '/tools/buildbot/bin/python'} 09:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:21:47 INFO - Running setup.py (path:/tmp/pip-q2SjyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:21:47 INFO - Running setup.py (path:/tmp/pip-wL_A30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:21:47 INFO - Running setup.py (path:/tmp/pip-GEuV68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:21:47 INFO - Running setup.py (path:/tmp/pip-vPwaqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:21:47 INFO - Running setup.py (path:/tmp/pip-CKFukB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:21:47 INFO - Running setup.py (path:/tmp/pip-qXOjfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:21:47 INFO - Running setup.py (path:/tmp/pip-i5Urmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:21:47 INFO - Running setup.py (path:/tmp/pip-cc5vlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:21:47 INFO - Running setup.py (path:/tmp/pip-KObzqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:21:47 INFO - Running setup.py (path:/tmp/pip-7dYcxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:21:47 INFO - Running setup.py (path:/tmp/pip-YLcbal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:21:47 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)) 09:21:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:21:47 INFO - Running setup.py (path:/tmp/pip-GwMhVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:21:48 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)) 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:21:48 INFO - Running setup.py (path:/tmp/pip-ztfvJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:21:48 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)) 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:21:48 INFO - Running setup.py (path:/tmp/pip-haAzQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:21:48 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)) 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:48 INFO - Running setup.py (path:/tmp/pip-YB66LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:21:48 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)) 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:21:48 INFO - Running setup.py (path:/tmp/pip-bVdds2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:21:48 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)) 09:21:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:21:48 INFO - Running setup.py (path:/tmp/pip-9Yf2N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:21:48 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)) 09:21:48 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)) 09:21:48 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)) 09:21:48 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)) 09:21:48 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)) 09:21:48 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)) 09:21:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21: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 09:21:50 INFO - Downloading blessings-1.6.tar.gz 09:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:21:50 INFO - Installing collected packages: blessings 09:21:50 INFO - Running setup.py install for blessings 09:21:50 INFO - Successfully installed blessings 09:21:50 INFO - Cleaning up... 09:21:50 INFO - Return code: 0 09:21:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:21:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:50 INFO - Reading from file tmpfile_stdout 09:21:50 INFO - Current package versions: 09:21:50 INFO - argparse == 1.2.1 09:21:50 INFO - blessings == 1.6 09:21:50 INFO - blobuploader == 1.2.4 09:21:50 INFO - docopt == 0.6.1 09:21:50 INFO - functools32 == 3.2.3-2 09:21:50 INFO - jsonschema == 2.5.1 09:21:50 INFO - manifestparser == 1.1 09:21:50 INFO - mozInstall == 1.12 09:21:50 INFO - mozcrash == 1.0 09:21:50 INFO - mozdebug == 0.1 09:21:50 INFO - mozdevice == 0.48 09:21:50 INFO - mozfile == 1.2 09:21:50 INFO - mozhttpd == 0.7 09:21:50 INFO - mozinfo == 0.9 09:21:50 INFO - mozleak == 0.1 09:21:50 INFO - mozlog == 3.4 09:21:50 INFO - moznetwork == 0.27 09:21:50 INFO - mozprocess == 0.23 09:21:50 INFO - mozprofile == 0.28 09:21:50 INFO - mozrunner == 6.13 09:21:50 INFO - mozscreenshot == 0.1 09:21:50 INFO - mozsystemmonitor == 0.3 09:21:50 INFO - moztest == 0.7 09:21:50 INFO - mozversion == 1.4 09:21:50 INFO - psutil == 3.1.1 09:21:50 INFO - requests == 1.2.3 09:21:50 INFO - wsgiref == 0.1.2 09:21:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:50 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:50 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 09:21:50 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 09:21:50 INFO - Using env: {'DISPLAY': ':0', 09:21:50 INFO - 'HOME': '/home/cltbld', 09:21:50 INFO - 'LANG': 'en_US.UTF-8', 09:21:50 INFO - 'LANGUAGE': 'en_US:en', 09:21:50 INFO - 'LOGNAME': 'cltbld', 09:21:50 INFO - 'MAIL': '/var/mail/cltbld', 09:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:50 INFO - 'MOZ_NO_REMOTE': '1', 09:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:50 INFO - 'NO_EM_RESTART': '1', 09:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:50 INFO - 'PWD': '/builds/slave/test', 09:21:50 INFO - 'SHELL': '/bin/bash', 09:21:50 INFO - 'SHLVL': '1', 09:21:50 INFO - 'TERM': 'linux', 09:21:50 INFO - 'TMOUT': '86400', 09:21:50 INFO - 'USER': 'cltbld', 09:21:50 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:50 INFO - '_': '/tools/buildbot/bin/python'} 09:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 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)) 09:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:21:51 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')]} 09:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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')]} 09:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:21:51 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 0x7f67c47eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ebca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', '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 09:21:51 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 09:21:51 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 09:21:51 INFO - Using env: {'DISPLAY': ':0', 09:21:51 INFO - 'HOME': '/home/cltbld', 09:21:51 INFO - 'LANG': 'en_US.UTF-8', 09:21:51 INFO - 'LANGUAGE': 'en_US:en', 09:21:51 INFO - 'LOGNAME': 'cltbld', 09:21:51 INFO - 'MAIL': '/var/mail/cltbld', 09:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:51 INFO - 'MOZ_NO_REMOTE': '1', 09:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:21:51 INFO - 'NO_EM_RESTART': '1', 09:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:51 INFO - 'PWD': '/builds/slave/test', 09:21:51 INFO - 'SHELL': '/bin/bash', 09:21:51 INFO - 'SHLVL': '1', 09:21:51 INFO - 'TERM': 'linux', 09:21:51 INFO - 'TMOUT': '86400', 09:21:51 INFO - 'USER': 'cltbld', 09:21:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:51 INFO - '_': '/tools/buildbot/bin/python'} 09:21:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:21:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:21:51 INFO - Cleaning up... 09:21:51 INFO - Return code: 0 09:21:51 INFO - Running post-action listener: _resource_record_post_action 09:21:51 INFO - Running post-action listener: _start_resource_monitoring 09:21:51 INFO - Starting resource monitoring. 09:21:51 INFO - [mozharness: 2016-11-15 17:21:51.281896Z] Finished create-virtualenv step (success) 09:21:51 INFO - [mozharness: 2016-11-15 17:21:51.282353Z] Running install step. 09:21:51 INFO - Running pre-action listener: _resource_record_pre_action 09:21:51 INFO - Running main action method: install 09:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:21:51 INFO - Reading from file tmpfile_stdout 09:21:51 INFO - Detecting whether we're running mozinstall >=1.0... 09:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:21:51 INFO - Reading from file tmpfile_stdout 09:21:51 INFO - Output received: 09:21:51 INFO - Usage: mozinstall [options] installer 09:21:51 INFO - Options: 09:21:51 INFO - -h, --help show this help message and exit 09:21:51 INFO - -d DEST, --destination=DEST 09:21:51 INFO - Directory to install application into. [default: 09:21:51 INFO - "/builds/slave/test"] 09:21:51 INFO - --app=APP Application being installed. [default: firefox] 09:21:51 INFO - mkdir: /builds/slave/test/build/application 09:21:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:21:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:22:08 INFO - Reading from file tmpfile_stdout 09:22:08 INFO - Output received: 09:22:08 INFO - /builds/slave/test/build/application/firefox/firefox 09:22:08 INFO - Running post-action listener: _resource_record_post_action 09:22:08 INFO - [mozharness: 2016-11-15 17:22:08.498758Z] Finished install step (success) 09:22:08 INFO - [mozharness: 2016-11-15 17:22:08.498998Z] Running run-tests step. 09:22:08 INFO - Running pre-action listener: _resource_record_pre_action 09:22:08 INFO - Running main action method: run_tests 09:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:22:08 INFO - Python 2.7.3 09:22:08 INFO - Return code: 0 09:22:08 INFO - grabbing minidump binary from tooltool 09:22:08 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')]} 09:22:08 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 0x18e8f60>, '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 0x18e9d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18ea1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:22:08 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 09:22:08 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 09:22:08 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 09:22:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:22:08 INFO - Return code: 0 09:22:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:22:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:22:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:22:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:22:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:22:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:22:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:22:08 INFO - Using env: {'DISPLAY': ':0', 09:22:08 INFO - 'HOME': '/home/cltbld', 09:22:08 INFO - 'LANG': 'en_US.UTF-8', 09:22:08 INFO - 'LANGUAGE': 'en_US:en', 09:22:08 INFO - 'LOGNAME': 'cltbld', 09:22:08 INFO - 'MAIL': '/var/mail/cltbld', 09:22:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:22:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:22:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:22:08 INFO - 'MOZ_NO_REMOTE': '1', 09:22:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:22:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:22:08 INFO - 'NO_EM_RESTART': '1', 09:22:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:22:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:22:08 INFO - 'PWD': '/builds/slave/test', 09:22:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:22:08 INFO - 'SHELL': '/bin/bash', 09:22:08 INFO - 'SHLVL': '1', 09:22:08 INFO - 'TERM': 'linux', 09:22:08 INFO - 'TMOUT': '86400', 09:22:08 INFO - 'USER': 'cltbld', 09:22:08 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942', 09:22:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:22:08 INFO - '_': '/tools/buildbot/bin/python'} 09:22:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:22:08 INFO - mozversion application_buildid: 20161115063600 09:22:08 INFO - mozversion application_changeset: b7d42c3980d12dff16df9f6077f34279aeef49d6 09:22:08 INFO - mozversion application_display_name: Nightly 09:22:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:22:08 INFO - mozversion application_name: Firefox 09:22:08 INFO - mozversion application_remotingname: firefox 09:22:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:22:08 INFO - mozversion application_vendor: Mozilla 09:22:08 INFO - mozversion application_version: 53.0a1 09:22:08 INFO - mozversion platform_buildid: 20161115063600 09:22:08 INFO - mozversion platform_changeset: b7d42c3980d12dff16df9f6077f34279aeef49d6 09:22:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:22:08 INFO - mozversion platform_version: 53.0a1 09:22:08 INFO - using testdate: 1479230528 09:22:08 INFO - actual date: 1479230528 09:22:08 INFO - starting webserver on 'localhost:37742' 09:22:08 INFO - SUITE-START | Running 2 tests 09:22:08 INFO - TEST-START | dromaeo_css 09:22:08 INFO - operating with platform_type : linux_ 09:22:08 INFO - Initialising browser for dromaeo_css test... 09:22:08 INFO - TEST-INFO | started process 20740 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphyGxVg/profile http://localhost:37742/getInfo.html) 09:22:13 INFO - PROCESS | 20740 | __metrics Screen width/height:1600/1200 09:22:13 INFO - PROCESS | 20740 | colorDepth:24 09:22:13 INFO - PROCESS | 20740 | Browser inner width/height: 1024/697 09:22:13 INFO - PROCESS | 20740 | __metrics 09:22:13 ERROR - PROCESS | 20740 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 09:22:14 INFO - TEST-INFO | 20740: exit 0 09:22:14 INFO - Browser initialized. 09:22:14 INFO - Running cycle 1/1 for dromaeo_css test... 09:22:14 INFO - TEST-INFO | started process 20868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphyGxVg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:22:27 INFO - PROCESS | 20868 | RSS: Main: 185978880 09:22:27 INFO - PROCESS | 20868 | 09:23:16 INFO - PROCESS | 20868 | 1479230596847 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] 09:25:28 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:37742/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37742/tests/dromaeo/cssquery-ext.html) 09:25:29 INFO - PROCESS | 20868 | RSS: Main: 197050368 09:25:29 INFO - PROCESS | 20868 | 09:28:31 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:37742/tests/dromaeo/cssquery-ext.html (next: http://localhost:37742/tests/dromaeo/cssquery-jquery.html) 09:28:32 INFO - PROCESS | 20868 | RSS: Main: 196870144 09:28:32 INFO - PROCESS | 20868 | 09:31:34 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:37742/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37742/tests/dromaeo/cssquery-mootools.html) 09:31:35 INFO - PROCESS | 20868 | RSS: Main: 198893568 09:31:35 INFO - PROCESS | 20868 | 09:34:37 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:37742/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37742/tests/dromaeo/cssquery-prototype.html) 09:34:37 INFO - PROCESS | 20868 | RSS: Main: 195334144 09:34:37 INFO - PROCESS | 20868 | 09:37:40 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:37742/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37742/tests/dromaeo/cssquery-yui.html) 09:37:40 INFO - PROCESS | 20868 | RSS: Main: 198742016 09:37:40 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | Cycle 1(1): loaded http://localhost:37742/tests/dromaeo/cssquery-yui.html (next: http://localhost:37742/tests/dromaeo/cssquery-dojo.html) 09:40:43 INFO - PROCESS | 20868 | RSS: Main: 198758400 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | __start_tp_report 09:40:43 INFO - PROCESS | 20868 | _x_x_mozilla_page_load 09:40:43 INFO - PROCESS | 20868 | _x_x_mozilla_page_load_details 09:40:43 INFO - PROCESS | 20868 | |i|pagename|runs| 09:40:43 INFO - PROCESS | 20868 | |0;dojo.html;3088.9073327800165;3098.0860646109395;3122.843857807109;3128.4368813613546;3150.054983504949;5284.920726189111;5419.214213938976;5485.424030476803;5513.889722205554;5519.9172012419795;5331.360236771593;5365.865853353668;5443.237946687467;5515.4760297771745;5517.200005999138;4828.299896515004;4843.418789745236;4928.334674818907;4964.898169938536;4981.576565991895;4822.204336284509;4887.951120488785;4972.651914365996;4987.47631498691;5019.472955339692;4751.524847515221;4830.951690483085;4901.8774530636665;4958.752062396902;4963.131451995904;4876.097921884463;4885.120678277908;4885.462599114095;4892.584130348924;4898.0693668203285;4803.03939212159;4818.903621927542;4836.637252206064;4839.9032019359765;4855.393075865517;5331.093714068617;5342.839714808562;5387.218853266294;5390.19147127934;5437.510624043815;5789.131630255453;5801.680907550083;5809.302883653946;5812.360640329561;5838.065909454509;5538.335399752015;5550.250716153308;5797.478226959552;5850.619709718854;5855.912161317584;5265.210218467222;5282.947170528284;5366.517013468807;5385.407605163429;5404.459554044564;5885.499732522783;5926.67403292823;5935.584509084409;5937.495312898365;5975.133605627247;5678.971605141948;5693.089105743061;5697;5701.857453563694;5707.771689132472;5588.944110558842;5646.378898321182;5665.433456654301;5670.979223739767;5778.104393818965;5741.138829175574;5786.103154011135;5792.189093526909;5827.533797296206;5887.61730487517;5805.970970145122;5842.561807864342;5846;5853.063509838491;5853.356130825606;4277;4339.609435150852;4458.331250312479;4500.887477813016;4535.070310586388;3882.902927426837;3902.180542086137;3903.2583809076755;3914.393269043303;3933.331333673282;5531.253280807039;5531.972340138354;5536.584756143306;5542.418046105182;5595.020871347498;5849.707514624251;5862;5864.325602555676;5867.471927526543;5870.559708021916;5287.735613219324;5293.867653308698;5355.410904800468;5523.392426833045;5538.695371754592;4915.066137433876;4924.803007879645;4930.359053323117;4939.678920870132;4973.577245934136;6003.5797494174985;6057.878842423127;6063.6664983426335;6078.665673387918;6104.816855494342;5819.82540523785;5831.446012628793;5834.883302333845;5838.357780644041;5840.737166827588;5854.619449735754;5867.647941123376;5932.288125424977;5964.642121472725;6047.274327080779;5657.660540367591;5702.7718891243885;5712.314522257356;5718.456746609066;5723.084306510938;5793.681347525927;5837.970810145922;5841.357450680337;5884;5894.145348924468;5631.2960879890015;5668.7165641718575;5693.089105743061;5699.51554117888;5701.8859622806485;5471.097268950738;5628.409017053151;5688.601797874109;5705.800296989585;5709.029464991045;5589.189567512769;5614.5789065821045;5623.409541998195;5636.4927156556105;5668.886622267614;5720.427957204246;5749.683767392834;5827.329857066492;5834.591578589458;5836.474717275296;5639;5651;5691.943080569141;5698.914516282176;5699.088145896637 09:40:43 INFO - PROCESS | 20868 | |1;ext.html;572.739403571375;583.2854752927664;592.0054308761285;601.1673831743035;602.8975074237379;41032.17935641285;43115;43144.60692413448;46183.30725039127;46335.53664463355;43914.7804260979;44304.556954430445;44413;44509.109817803626;44548.88627784307;8648.870266945985;8701.17338852808;8701.869471957894;8720.084391138935;8787.428817126898;8616.00915894674;8674.739757807245;8696.739097827076;8731.126887311282;8768.473891566495;8657.177568131048;8691.130886911322;8727.170918762738;8761.386702930797;8804.471731696087;8658.653653853902;8688.174623410765;8700.695475658385;8702.30381569476;8714.389992700513;8437.451565648213;8481.321494280442;8509.191626795444;8535.317174626016;8563.743087707378;39715.60284397177;40135.39796903049;40437.59562404368;40551.188976220605;40620.18759624791;3401.132711158639;3653.598104208535;3723.441483777428;3889.436031775405;4030.5163380394542;30478.695213047806;30564.54153187704;30659.540106898414;30863.537046944315;31089.844550777103;4132.421460995463;4160.729552579072;4220.78896055196;4233.23801715691;4282.207791558571;330486;333268;336789;337515;340272.9999999975;56175;56637.433625663216;56846.7157664209;56876.431235687116;56883.43116568864;61627.38372616306;62024.37975620276;62073.37926620767;62211;62314;16469.258883350278;16513.100993385673;16555.66888662244;16558.923669961656;16719;11995.580154694544;12114.333711645768;12168.452419641137;12185;12247.081468889868;17553.473395798148;18265;18389.448316550526;18477.1685274163;18533.90733046353;6944.583325000516;7138.39323657495;7221.386182174574;7240.855182896313;7286.380657644159;922.4557511068501;1073.5222825842425;1077.9514921828536;1085.8099832529276;1099.290957332516;31568.526472102938;31589;31639.841800790848;32005.559749811313;32024.83987580094;1039.3504059962524;1052.310736467615;1069.8823129455754;1133.2747041893194;1180.6340034589305;16507.504774856774;16949.742274446755;17118.315267389415;17143;17162.970221786734;501033;503387;505058;506747;506807;56455;56480.717596411756;56870;56986;57084.143737843966;1259.175240217659;1326.4296352568294;1330.155351351879;1330.5409633676366;1342.9462821487227;30023.54964675488;31285.74857005694;31979.36041279208;32075.67924320727;32253.838730807136;50119;50572;50654.493455066455;50715.364080824525;50775.492245077075;418655;418822;419230;419470;419636;28168.29579260535;28218.576721349607;28268.293292667026;28304.43391132207;28572.142835714963;44677.329840051774;45153;45651.31523027224;46122;47019.294710580056;38282.80858595689;38524.80737596406;38795.61204388033;38945;40893.79553102215;39584.60415395924;39597.40603890886;40060.94807006018;40172.598274016884;41256;34971;35054.47418288779;38994.80502597469;40588.1882362357;40803.59196408117;32912.67087329096;36073.63926360703;36143.638563614026;36548.26903461863;36735;27134;27449.17652470429;27470.450590987668;27818;27974.764852039807 09:40:43 INFO - PROCESS | 20868 | |2;jquery.html;379.476322674709;386.8781333879826;398.76871414579546;399.41685139696045;417.7201275145652;17802.910985445087;19315.517112072204;19326.42020739378;19341.419757407264;19459.708104378446;18800.905995470002;18823;19074.332398366027;19133.61732765344;19259.614807703838;5415.214793854889;5425.511703946644;5559.277293951781;5596.748146333404;5665.8583535411735;5463.453654634544;5599.628091117682;5600.8319750407345;5605.495505404513;5616.101423772197;5435.347758269013;5495.587830912677;5558.555315574765;5715.9997000524945;5745.109508026263;5771.797987070453;5803.042497987827;5811.3316968548315;5830.125481177814;5832.387599302076;5401.864953376158;5642.830715078554;5644.209810626516;5682.914756278659;5690;12158.635240942785;12212.511499540096;12285.324307163102;21031.78968210329;21941.670874936888;2167.8157356624706;2208.1719355241785;2320.640300753386;2384.0582969727034;2646.8676566171616;9915.405075695482;10130.290879638429;10377.377357358582;10812.35125892449;10858.185636077247;1771.8394451634201;1795.5152108930515;1831.7252412138153;1837.1549087419803;1915.5689969756831;83965;88073.55963220143;89051.55474222652;90018.5499072507;90167.54916225377;11024.724381890357;11117.666470005752;11128.777424451628;11306.434678266054;11365.886341136647;15544.76682849758;15628;15686.686266274839;15730;15739.921300393426;7909.485883417559;8063.717769878026;8087.676492940216;8191.713290034821;8357.749267521984;7647.732329368446;7701.345385642171;7914.525128492309;7963.641636126388;8052.355811535063;4603.401557797465;4792.592629626451;4800.039842621659;4846.418429788448;4865.416150061945;1887.045699713151;2015.4256037029377;2018.2835093541876;2024.321852179507;2047.5802460495563;901.2114399900088;927.5779520318239;938.5635679409107;959.3811991265594;979.9853002204973;18375.356862509747;19136.521586960436;19380.806191938183;19446.513837154183;19760.209591616174;931.2131249094505;941.9623215071321;954.6372378496127;973.4208146153028;1012.5797793915442;10711.571537138427;10765.008473432441;10966.342019478856;11007.834882476769;11094.611688590861;420282;450560;463309;463322;463567;86579.56710216409;91181;91281.54359228293;91406.54296728474;91877;953.7758626722576;956.168133723651;987.5950860147306;995.8149801735912;996.3324572536418;16620.335186592885;16905.746413803558;17188;17340.47978560645;17495.737563936298;42136.57863421326;42615.57384426116;42716.35925461183;42938;43185.35221971736;56574.71712641411;57355;57504.71247643735;58263;58741;8147.83704325922;8183.140770219279;8324.875126872981;8338.291245244221;8378.832423351621;10925.344479331265;12239.938800306298;12258.509659613872;12621.116521843383;12875.098743087894;10701.678949631523;10850.131989440668;10910.563577456813;11030.117590592894;11154.832677510007;10573.312734672221;10602.575896964343;10760.515776789907;10958.123350131811;11085.334879907232;10909.454527273763;11045.944770276097;11087.22389432732;11148.665540033811;11343.773124537629;7209.6034718091005;7693.269139431745;7703.3067023968115;8274;8385.16148385181;8663.653453861774;10801.837972430263;11185.38480383554;11608.767824643292;11673.941630291794 09:40:43 INFO - PROCESS | 20868 | |3;mootools.html;1433.2905211920095;1447.6887469194126;1585.563969908275;1688.9746653800203;1707.257343055771;7496.625168741569;7760.534367937914;7968.442209045369;8416.915830841697;8498.787530311745;7883.8423231535335;8219.260266576008;8246.793830154249;8432.241098301152;8441.282490988273;2291.564602725481;2318.2813327868416;2320.969151992007;2325.802306803915;2329.0683726509446;2313.144136669435;2324.5583339165587;2371.3834403055243;2371.9169829055986;2373.95252094958;2282.7260728712495;2286.1084177170915;2290.530441259538;2302.7236731592147;2317.2700599311247;2192.090282532747;2205.4045407739823;2214.5570885822817;2217.977820221793;2222.388843068153;2198.8350873684376;2199.6590528468114;2205.128974055255;2214.7895949884737;2216.0581752755015;8374.41379103463;8462;8492.53291068991;8515.616797244138;8531.74404767858;4961.404631444214;5048.62135339851;5102.413222479388;5104.795808167669;5111;3101.9689803101905;3242.610886693612;3396.932061358759;3430.9142271443166;3432;1063.882972872991;1086.9130469562494;1092.3500517192258;1097.742030622803;1137.6473293279028;11160.16298777595;11161.772205057438;11182.944085279685;11222.831657525143;11246.887531124748;4374.147041326911;4424.269995450779;4464.910701785946;4491.393661855608;4648.58162765346;9752.46361450127;9871.111599955895;9886.604535818631;9918.454485003249;9919.80160396788;5170.405403378584;5171.4311425743135;5172.353455818023;5174.586033117342;5196.870078247998;4557.567031132104;4639.582437580634;4709.858704238878;4741.5021422750115;4742.881427964328;3539.663731945461;3662.6520480554304;3680.429533422324;3685.4656074868994;3702.777833330009;1174.5686429091697;1200.3098218524383;1200.3458115326994;1202.8556573211097;1213.2832042659538;742.4246209187922;853.1298075962484;902.1069141549818;923.2844545477309;923.2844545477309;5612.831615051555;5636.126400407943;5667.489925906606;5777.711114444261;5931.4958228550195;408.81807595619665;423.24239611095794;429.3645404800912;430.6232046958911;430.7544699521243;3868.8200098969523;4021.376686613521;4032.9596704032583;4046.959530404717;4149.33610622299;10035.197184225244;10262.179025678077;10390.428526430967;10451.529681164366;10454.163666906628;10241.94879025615;10257.692269231935;10381;10392.064714175609;10402.219833512365;7662.73180438682;7878.487898286593;7907.644156012993;7916.129225785159;7921.722739704198;5474.5894057945015;5531.3362396512675;5555.250041244381;5576.665400076008;5641.533201367756;9335.906640933505;9435.858462123211;9459.479728614991;9509.239260858976;9519.286053545873;9081.318901082577;9511.334206605472;9523.23814094857;9728.17310528613;9740;7231.240719724353;7446.25537446251;7496.812579685334;7525.58609276495;7561.432892532972;8236.888020117207;8314.750557483285;8333.916660833314;8397.118302578141;8398.286145677686;6868.896966545406;6912.135983002125;7094.9290507094265;7423.665935032828;7655;7049.436045116276;7095.645217739196;7122.216556178712;7144.214136445091;7335.596542190231;6511.772087976898;6587.703553340016;6629.773491904013;6651.667416629246;6659.500537459613;5035.118854200574;5120.436751957207;5186.377634683862;5280.656757310762;5313.601479888946;4880.92678609814;5045.823396181116;5050.141475949171;5213.973930130325;5265.183511688461 09:40:43 INFO - PROCESS | 20868 | |4;prototype.html;325.2097403309956;330.41516515767086;336.9898903032909;338.96610338966104;339.52466546834444;5447.618666693333;5502.422245664207;5529.419410961847;5555;5576.33084029916;5377.247185394048;5430.859519500909;5431.809886653958;5502.119660854264;5507.146392309199;3986.5614782373914;4075.4498142750645;4117.60882716143;4146.502419709639;4188.916221675565;4156.646685031776;4175.976885663017;4183.728057676257;4192.601702838226;4217.6891140454745;4143.212789569987;4179.164167166564;4179.477565304337;4185.414042034103;4193.245215861144;4110.753354798707;4149.2531344358;4169.791510424497;4202.70581059326;4208.905684522031;3693.815309234554;3717.7211709121925;3722.8883133506038;3723.6222597638775;3740.3080430120244;5259.184826351883;5269;5302.3637163540625;5308.867278318035;5332.466753324637;4694.835680751157;4844.75776211188;4859.708417494961;4862.854114376539;4863.392075990501;5622.184783206412;5624.690642014688;5636.408177141382;5638.618538458063;5666.951613951433;4142.91714165715;4156.231097247019;4160.479940007499;4180.979095104505;4191.91616167675;5567.3040869891265;5763.9135412968835;5847.707614619295;5949.524038076944;5959.821205363846;4016.5983401660183;4030.173814368106;4032.7700051483994;4048.7975601219823;4083.714140010171;4096.692748043909;4100.487439070116;4108.6918481114035;4136.2968295389255;4142.896427589274;4610.7781437918975;4723.7401942893475;4736.455307639597;4750.572448479654;4775.498572649822;5628;5639.774409023676;5642.971785141131;5661.688607126565;5675.2054712340305;1390.8122403475604;1405.276282714403;1415.2569900802162;1417.3905220755175;1419.929003549839;932.3566738950238;953.9458897917701;963.629002833914;981.8625392445064;984.6307634637011;5144.588432925357;5213.218017297359;5227.895442091137;5265.183896496049;5309.761060752276;5586.413426590231;5604.85987850307;5631.211630371751;5670.347909990404;5670.716464176775;5120.206368012964;5266.762995665128;5267.841964740987;5333.173358129496;5399.406065332889;2954.763618910482;2999.710124646423;3014.276573622315;3017.2456885778556;3019.8222693149687;5859.736311865976;5903.793367232126;5918;5921.940780592139;5936.111846740392;5532.972335138298;5681.687507187145;5741.971290143522;5746;5756.65460072397;5844.853878653068;5863.296404431496;5869.358788545086;5871.236739223874;5902.940970590239;5485.561155107662;5709.429057094258;5723.651663776737;5726.570507212059;5812.169166712472;5803.15645333775;5806.390329015392;5810.477057064884;5818.44724751148;5851.180834683063;6068.78759243442;6078.908816367846;6094.481969032505;6110.236220472441;6114.174586430953;4041.2725709372594;4202.285611446123;4233.153369326209;4233.597808208216;4248.87253382399;5782.653040817564;5841.853953651193;5843.415658434123;5863.214972887844;5895.911561326498;5539.861503462445;5706.914396284142;5740.741666625096;5754.741036653444;5797.782465682254;5642.379338272704;5650;5654.46282603152;5657.331087329166;5678.403767604342;5574.442555744393;5577.888442231051;5617.354004289559;5618.438156184349;5654.575906806924;5498.725063746877;5704.3725190228215;5718.685472298897;5723.394261615156;5749.626274292157;5580.302462192226;5582.27430434041;5593.1263026886445;5614.624417017857;5620.241267428844 09:40:43 INFO - PROCESS | 20868 | |5;yui.html;691.5090285897013;725.8838585826269;727.2799928071208;792.6433105102706;797.8922845415867;12826.935865320673;13545.322733863317;13612.251326177056;13663.521776737816;13681.726365472685;9864.802703945918;13209.273489958048;13406.195628262287;13419.932900335485;13428.060035797498;657.447743895128;767.3209209849296;785.7446329942763;789.6643926331315;790.6521130702472;759.3773106053038;769.7690692792168;772.1352085664064;773.5281478298234;774.0827119862952;831.4138532334689;833.62903507939;838.5597561280316;839.630562552478;840.1178762299561;827.0406328658758;833.5957060825494;834.1783343406739;835.6156168162653;837.3385025829588;611.0101635350716;611.5321778839192;612.3233826621564;612.4151435379247;613.1262950295855;12353.258804471761;12355.32045737493;12693.11148219625;12694.619161425171;12698;13446;13569.796453053212;14269.286535673175;14279.714405711931;14426.783598246035;10993.311053397338;11564.42177891102;11572;11655.941720291345;11827.704307392298;3493.598236202844;3557.5730912290433;3557.964420355789;3591.712662986955;3604.6395360464007;62457.68771156161;62599.68700156516;62884.68557657228;63103.6844815773;64095;10377.792444151075;10483.580656773796;10663.507109004746;10878.619248326271;10951.33182485809;19298;19452;19557.413277601696;19920.601587968158;20206.29277975264;7639.465237433437;7717.614119294013;7792.961035194788;7857.371410287164;7919.802004949807;4377.190219809346;4453.242948698729;4462.509123996423;4518.164139634178;4568.954310456919;3355;3418.025862629139;3428.8971330860113;3482.8258587070545;3483.7038851697384;568.3492401200602;578.5400606517828;628.6228263042138;629.3486241739778;675.3719041291548;702.2977022977022;712.3482013957171;729.0194688144437;738.8522295540806;744.2334395572569;8039.557824319601;8075.959620201861;8278.793030174173;8284.337253019745;8605.182507661762;571.012148982263;650.2489624483729;668.0513670587777;715.996420017907;736.131364989307;3948.0129967508124;4068.1863627274665;4134.37984302351;4163.937540936889;4183.142455796555;53584;53835.19247211295;63058;90468;90606.54696726475;77510.6124469374;78899.60550197212;78923.84253970809;79124.6043769789;80860.78708819373;67754.82045462543;69590;69661.65169174223;71934;73612.63193683997;7715;7929.207079292025;8027.598620068857;8396;8662;43506.56493435025;44995;45467.772661136485;47291.763541182074;47379.28931066106;60563.39436605578;61847;63003.36996629975;63838.68080659567;64327.67836160789;12003.75992480163;12282.631521054383;12439.689007774878;12572.685682858002;12711.682207944876;13348;13875.167489950636;14084.929575352058;14217.679634913733;14531.564053078424;11841.46713397882;11991.400429978292;12047.216930899463;12049.277043377426;12586.370681466073;13490.448598411309;13627.727445451234;13984.091034082752;14371.353289101806;14406.567802965928;11211.271267367594;11435.714107147054;11548.769024619629;11766.235194712317;12105.273683579013;10198.337108088248;10402.47987600632;10410.947945260225;10475.58097676115;10763.300385474919;10231.795364092824;10522.21083418762;10749.731256718645;10865.945670271914;10871.184661150288 09:40:43 INFO - PROCESS | 20868 | __end_tp_report 09:40:43 INFO - PROCESS | 20868 | __start_cc_report 09:40:43 INFO - PROCESS | 20868 | _x_x_mozilla_cycle_collect,332 09:40:43 INFO - PROCESS | 20868 | __end_cc_report 09:40:43 INFO - PROCESS | 20868 | __startTimestamp1479231643972__endTimestamp 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | ------- Summary: start ------- 09:40:43 INFO - PROCESS | 20868 | Number of tests: 6 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | [#0] dojo.html Cycles:165 Average:5379.06 Median:5628.41 stddev:628.30 (11.2%) stddev-sans-first:603.99 09:40:43 INFO - PROCESS | 20868 | Values: 3088.9 3098.1 3122.8 3128.4 3150.1 5284.9 5419.2 5485.4 5513.9 5519.9 5331.4 5365.9 5443.2 5515.5 5517.2 4828.3 4843.4 4928.3 4964.9 4981.6 4822.2 4888.0 4972.7 4987.5 5019.5 4751.5 4831.0 4901.9 4958.8 4963.1 4876.1 4885.1 4885.5 4892.6 4898.1 4803.0 4818.9 4836.6 4839.9 4855.4 5331.1 5342.8 5387.2 5390.2 5437.5 5789.1 5801.7 5809.3 5812.4 5838.1 5538.3 5550.3 5797.5 5850.6 5855.9 5265.2 5282.9 5366.5 5385.4 5404.5 5885.5 5926.7 5935.6 5937.5 5975.1 5679.0 5693.1 5697.0 5701.9 5707.8 5588.9 5646.4 5665.4 5671.0 5778.1 5741.1 5786.1 5792.2 5827.5 5887.6 5806.0 5842.6 5846.0 5853.1 5853.4 4277.0 4339.6 4458.3 4500.9 4535.1 3882.9 3902.2 3903.3 3914.4 3933.3 5531.3 5532.0 5536.6 5542.4 5595.0 5849.7 5862.0 5864.3 5867.5 5870.6 5287.7 5293.9 5355.4 5523.4 5538.7 4915.1 4924.8 4930.4 4939.7 4973.6 6003.6 6057.9 6063.7 6078.7 6104.8 5819.8 5831.4 5834.9 5838.4 5840.7 5854.6 5867.6 5932.3 5964.6 6047.3 5657.7 5702.8 5712.3 5718.5 5723.1 5793.7 5838.0 5841.4 5884.0 5894.1 5631.3 5668.7 5693.1 5699.5 5701.9 5471.1 5628.4 5688.6 5705.8 5709.0 5589.2 5614.6 5623.4 5636.5 5668.9 5720.4 5749.7 5827.3 5834.6 5836.5 5639.0 5651.0 5691.9 5698.9 5699.1 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | [#1] ext.html Cycles:180 Average:58031.67 Median:40711.89 stddev:112628.10 (276.6%) stddev-sans-first:112861.43 09:40:43 INFO - PROCESS | 20868 | Values: 572.7 583.3 592.0 601.2 602.9 41032.2 43115.0 43144.6 46183.3 46335.5 43914.8 44304.6 44413.0 44509.1 44548.9 8648.9 8701.2 8701.9 8720.1 8787.4 8616.0 8674.7 8696.7 8731.1 8768.5 8657.2 8691.1 8727.2 8761.4 8804.5 8658.7 8688.2 8700.7 8702.3 8714.4 8437.5 8481.3 8509.2 8535.3 8563.7 39715.6 40135.4 40437.6 40551.2 40620.2 3401.1 3653.6 3723.4 3889.4 4030.5 30478.7 30564.5 30659.5 30863.5 31089.8 4132.4 4160.7 4220.8 4233.2 4282.2 330486.0 333268.0 336789.0 337515.0 340273.0 56175.0 56637.4 56846.7 56876.4 56883.4 61627.4 62024.4 62073.4 62211.0 62314.0 16469.3 16513.1 16555.7 16558.9 16719.0 11995.6 12114.3 12168.5 12185.0 12247.1 17553.5 18265.0 18389.4 18477.2 18533.9 6944.6 7138.4 7221.4 7240.9 7286.4 922.5 1073.5 1078.0 1085.8 1099.3 31568.5 31589.0 31639.8 32005.6 32024.8 1039.4 1052.3 1069.9 1133.3 1180.6 16507.5 16949.7 17118.3 17143.0 17163.0 501033.0 503387.0 505058.0 506747.0 506807.0 56455.0 56480.7 56870.0 56986.0 57084.1 1259.2 1326.4 1330.2 1330.5 1342.9 30023.5 31285.7 31979.4 32075.7 32253.8 50119.0 50572.0 50654.5 50715.4 50775.5 418655.0 418822.0 419230.0 419470.0 419636.0 28168.3 28218.6 28268.3 28304.4 28572.1 44677.3 45153.0 45651.3 46122.0 47019.3 38282.8 38524.8 38795.6 38945.0 40893.8 39584.6 39597.4 40060.9 40172.6 41256.0 34971.0 35054.5 38994.8 40588.2 40803.6 32912.7 36073.6 36143.6 36548.3 36735.0 27134.0 27449.2 27470.5 27818.0 27974.8 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | [#2] jquery.html Cycles:180 Average:27780.70 Median:42376.08 stddev:75016.65 (177.0%) stddev-sans-first:75198.88 09:40:43 INFO - PROCESS | 20868 | Values: 379.5 386.9 398.8 399.4 417.7 17802.9 19315.5 19326.4 19341.4 19459.7 18800.9 18823.0 19074.3 19133.6 19259.6 5415.2 5425.5 5559.3 5596.7 5665.9 5463.5 5599.6 5600.8 5605.5 5616.1 5435.3 5495.6 5558.6 5716.0 5745.1 5771.8 5803.0 5811.3 5830.1 5832.4 5401.9 5642.8 5644.2 5682.9 5690.0 12158.6 12212.5 12285.3 21031.8 21941.7 2167.8 2208.2 2320.6 2384.1 2646.9 9915.4 10130.3 10377.4 10812.4 10858.2 1771.8 1795.5 1831.7 1837.2 1915.6 83965.0 88073.6 89051.6 90018.5 90167.5 11024.7 11117.7 11128.8 11306.4 11365.9 15544.8 15628.0 15686.7 15730.0 15739.9 7909.5 8063.7 8087.7 8191.7 8357.7 7647.7 7701.3 7914.5 7963.6 8052.4 4603.4 4792.6 4800.0 4846.4 4865.4 1887.0 2015.4 2018.3 2024.3 2047.6 901.2 927.6 938.6 959.4 980.0 18375.4 19136.5 19380.8 19446.5 19760.2 931.2 942.0 954.6 973.4 1012.6 10711.6 10765.0 10966.3 11007.8 11094.6 420282.0 450560.0 463309.0 463322.0 463567.0 86579.6 91181.0 91281.5 91406.5 91877.0 953.8 956.2 987.6 995.8 996.3 16620.3 16905.7 17188.0 17340.5 17495.7 42136.6 42615.6 42716.4 42938.0 43185.4 56574.7 57355.0 57504.7 58263.0 58741.0 8147.8 8183.1 8324.9 8338.3 8378.8 10925.3 12239.9 12258.5 12621.1 12875.1 10701.7 10850.1 10910.6 11030.1 11154.8 10573.3 10602.6 10760.5 10958.1 11085.3 10909.5 11045.9 11087.2 11148.7 11343.8 7209.6 7693.3 7703.3 8274.0 8385.2 8663.7 10801.8 11185.4 11608.8 11673.9 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | [#3] mootools.html Cycles:180 Average:5514.75 Median:5076.28 stddev:3093.37 (60.9%) stddev-sans-first:3086.85 09:40:43 INFO - PROCESS | 20868 | Values: 1433.3 1447.7 1585.6 1689.0 1707.3 7496.6 7760.5 7968.4 8416.9 8498.8 7883.8 8219.3 8246.8 8432.2 8441.3 2291.6 2318.3 2321.0 2325.8 2329.1 2313.1 2324.6 2371.4 2371.9 2374.0 2282.7 2286.1 2290.5 2302.7 2317.3 2192.1 2205.4 2214.6 2218.0 2222.4 2198.8 2199.7 2205.1 2214.8 2216.1 8374.4 8462.0 8492.5 8515.6 8531.7 4961.4 5048.6 5102.4 5104.8 5111.0 3102.0 3242.6 3396.9 3430.9 3432.0 1063.9 1086.9 1092.4 1097.7 1137.6 11160.2 11161.8 11182.9 11222.8 11246.9 4374.1 4424.3 4464.9 4491.4 4648.6 9752.5 9871.1 9886.6 9918.5 9919.8 5170.4 5171.4 5172.4 5174.6 5196.9 4557.6 4639.6 4709.9 4741.5 4742.9 3539.7 3662.7 3680.4 3685.5 3702.8 1174.6 1200.3 1200.3 1202.9 1213.3 742.4 853.1 902.1 923.3 923.3 5612.8 5636.1 5667.5 5777.7 5931.5 408.8 423.2 429.4 430.6 430.8 3868.8 4021.4 4033.0 4047.0 4149.3 10035.2 10262.2 10390.4 10451.5 10454.2 10241.9 10257.7 10381.0 10392.1 10402.2 7662.7 7878.5 7907.6 7916.1 7921.7 5474.6 5531.3 5555.3 5576.7 5641.5 9335.9 9435.9 9459.5 9509.2 9519.3 9081.3 9511.3 9523.2 9728.2 9740.0 7231.2 7446.3 7496.8 7525.6 7561.4 8236.9 8314.8 8333.9 8397.1 8398.3 6868.9 6912.1 7094.9 7423.7 7655.0 7049.4 7095.6 7122.2 7144.2 7335.6 6511.8 6587.7 6629.8 6651.7 6659.5 5035.1 5120.4 5186.4 5280.7 5313.6 4880.9 5045.8 5050.1 5214.0 5265.2 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | [#4] prototype.html Cycles:180 Average:4744.59 Median:5500.42 stddev:1399.96 (25.5%) stddev-sans-first:1364.02 09:40:43 INFO - PROCESS | 20868 | Values: 325.2 330.4 337.0 339.0 339.5 5447.6 5502.4 5529.4 5555.0 5576.3 5377.2 5430.9 5431.8 5502.1 5507.1 3986.6 4075.4 4117.6 4146.5 4188.9 4156.6 4176.0 4183.7 4192.6 4217.7 4143.2 4179.2 4179.5 4185.4 4193.2 4110.8 4149.3 4169.8 4202.7 4208.9 3693.8 3717.7 3722.9 3723.6 3740.3 5259.2 5269.0 5302.4 5308.9 5332.5 4694.8 4844.8 4859.7 4862.9 4863.4 5622.2 5624.7 5636.4 5638.6 5667.0 4142.9 4156.2 4160.5 4181.0 4191.9 5567.3 5763.9 5847.7 5949.5 5959.8 4016.6 4030.2 4032.8 4048.8 4083.7 4096.7 4100.5 4108.7 4136.3 4142.9 4610.8 4723.7 4736.5 4750.6 4775.5 5628.0 5639.8 5643.0 5661.7 5675.2 1390.8 1405.3 1415.3 1417.4 1419.9 932.4 953.9 963.6 981.9 984.6 5144.6 5213.2 5227.9 5265.2 5309.8 5586.4 5604.9 5631.2 5670.3 5670.7 5120.2 5266.8 5267.8 5333.2 5399.4 2954.8 2999.7 3014.3 3017.2 3019.8 5859.7 5903.8 5918.0 5921.9 5936.1 5533.0 5681.7 5742.0 5746.0 5756.7 5844.9 5863.3 5869.4 5871.2 5902.9 5485.6 5709.4 5723.7 5726.6 5812.2 5803.2 5806.4 5810.5 5818.4 5851.2 6068.8 6078.9 6094.5 6110.2 6114.2 4041.3 4202.3 4233.2 4233.6 4248.9 5782.7 5841.9 5843.4 5863.2 5895.9 5539.9 5706.9 5740.7 5754.7 5797.8 5642.4 5650.0 5654.5 5657.3 5678.4 5574.4 5577.9 5617.4 5618.4 5654.6 5498.7 5704.4 5718.7 5723.4 5749.6 5580.3 5582.3 5593.1 5614.6 5620.2 09:40:43 INFO - PROCESS | 20868 | 09:40:43 INFO - PROCESS | 20868 | [#5] yui.html Cycles:180 Average:17151.57 Median:25018.36 stddev:22738.90 (90.9%) stddev-sans-first:22769.10 09:40:43 INFO - PROCESS | 20868 | Values: 691.5 725.9 727.3 792.6 797.9 12826.9 13545.3 13612.3 13663.5 13681.7 9864.8 13209.3 13406.2 13419.9 13428.1 657.4 767.3 785.7 789.7 790.7 759.4 769.8 772.1 773.5 774.1 831.4 833.6 838.6 839.6 840.1 827.0 833.6 834.2 835.6 837.3 611.0 611.5 612.3 612.4 613.1 12353.3 12355.3 12693.1 12694.6 12698.0 13446.0 13569.8 14269.3 14279.7 14426.8 10993.3 11564.4 11572.0 11655.9 11827.7 3493.6 3557.6 3558.0 3591.7 3604.6 62457.7 62599.7 62884.7 63103.7 64095.0 10377.8 10483.6 10663.5 10878.6 10951.3 19298.0 19452.0 19557.4 19920.6 20206.3 7639.5 7717.6 7793.0 7857.4 7919.8 4377.2 4453.2 4462.5 4518.2 4569.0 3355.0 3418.0 3428.9 3482.8 3483.7 568.3 578.5 628.6 629.3 675.4 702.3 712.3 729.0 738.9 744.2 8039.6 8076.0 8278.8 8284.3 8605.2 571.0 650.2 668.1 716.0 736.1 3948.0 4068.2 4134.4 4163.9 4183.1 53584.0 53835.2 63058.0 90468.0 90606.5 77510.6 78899.6 78923.8 79124.6 80860.8 67754.8 69590.0 69661.7 71934.0 73612.6 7715.0 7929.2 8027.6 8396.0 8662.0 43506.6 44995.0 45467.8 47291.8 47379.3 60563.4 61847.0 63003.4 63838.7 64327.7 12003.8 12282.6 12439.7 12572.7 12711.7 13348.0 13875.2 14084.9 14217.7 14531.6 11841.5 11991.4 12047.2 12049.3 12586.4 13490.4 13627.7 13984.1 14371.4 14406.6 11211.3 11435.7 11548.8 11766.2 12105.3 10198.3 10402.5 10410.9 10475.6 10763.3 10231.8 10522.2 10749.7 10865.9 10871.2 09:40:43 INFO - PROCESS | 20868 | -------- Summary: end -------- 09:40:43 INFO - PROCESS | 20868 | 09:40:44 INFO - TEST-INFO | 20868: exit 0 09:40:45 INFO - TEST-OK | dromaeo_css | took 1116232ms 09:40:45 INFO - TEST-START | kraken 09:40:45 INFO - operating with platform_type : linux_ 09:40:45 INFO - Initialising browser for kraken test... 09:40:45 INFO - TEST-INFO | started process 21231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnqAVL/profile http://localhost:37742/getInfo.html) 09:40:49 INFO - PROCESS | 21231 | __metrics Screen width/height:1600/1200 09:40:49 INFO - PROCESS | 21231 | colorDepth:24 09:40:49 INFO - PROCESS | 21231 | Browser inner width/height: 1024/697 09:40:49 INFO - PROCESS | 21231 | __metrics 09:40:49 ERROR - PROCESS | 21231 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 09:40:50 INFO - TEST-INFO | 21231: exit 0 09:40:50 INFO - Browser initialized. 09:40:50 INFO - Running cycle 1/1 for kraken test... 09:40:50 INFO - TEST-INFO | started process 21356 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRnqAVL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:41:03 INFO - PROCESS | 21356 | RSS: Main: 186286080 09:41:03 INFO - PROCESS | 21356 | 09:41:05 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37742/tests/kraken/driver.html?testName=audio-beat-detection) 09:41:06 INFO - PROCESS | 21356 | RSS: Main: 199458816 09:41:06 INFO - PROCESS | 21356 | 09:41:09 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37742/tests/kraken/driver.html?testName=audio-dft) 09:41:10 INFO - PROCESS | 21356 | RSS: Main: 197492736 09:41:10 INFO - PROCESS | 21356 | 09:41:12 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37742/tests/kraken/driver.html?testName=audio-fft) 09:41:13 INFO - PROCESS | 21356 | RSS: Main: 193933312 09:41:13 INFO - PROCESS | 21356 | 09:41:15 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37742/tests/kraken/driver.html?testName=audio-oscillator) 09:41:16 INFO - PROCESS | 21356 | RSS: Main: 194772992 09:41:16 INFO - PROCESS | 21356 | 09:41:18 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37742/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:41:19 INFO - PROCESS | 21356 | RSS: Main: 194748416 09:41:19 INFO - PROCESS | 21356 | 09:41:22 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37742/tests/kraken/driver.html?testName=imaging-darkroom) 09:41:22 INFO - PROCESS | 21356 | RSS: Main: 200339456 09:41:22 INFO - PROCESS | 21356 | 09:41:26 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37742/tests/kraken/driver.html?testName=imaging-desaturate) 09:41:26 INFO - PROCESS | 21356 | RSS: Main: 196030464 09:41:26 INFO - PROCESS | 21356 | 09:41:29 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37742/tests/kraken/driver.html?testName=json-parse-financial) 09:41:30 INFO - PROCESS | 21356 | RSS: Main: 197169152 09:41:30 INFO - PROCESS | 21356 | 09:41:31 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37742/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:41:32 INFO - PROCESS | 21356 | RSS: Main: 197234688 09:41:32 INFO - PROCESS | 21356 | 09:41:34 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:41:34 INFO - PROCESS | 21356 | RSS: Main: 197124096 09:41:34 INFO - PROCESS | 21356 | 09:41:37 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:41:37 INFO - PROCESS | 21356 | RSS: Main: 197640192 09:41:37 INFO - PROCESS | 21356 | 09:41:40 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:41:41 INFO - PROCESS | 21356 | RSS: Main: 197771264 09:41:41 INFO - PROCESS | 21356 | 09:41:44 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:41:44 INFO - PROCESS | 21356 | RSS: Main: 197881856 09:41:44 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | Cycle 1(1): loaded http://localhost:37742/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37742/tests/kraken/driver.html?testName=ai-astar) 09:41:46 INFO - PROCESS | 21356 | RSS: Main: 199208960 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | __start_tp_report 09:41:46 INFO - PROCESS | 21356 | _x_x_mozilla_page_load 09:41:46 INFO - PROCESS | 21356 | _x_x_mozilla_page_load_details 09:41:46 INFO - PROCESS | 21356 | |i|pagename|runs| 09:41:46 INFO - PROCESS | 21356 | |0;ai-astar;104;112;113;112;114;111;112;113;113;113 09:41:46 INFO - PROCESS | 21356 | |1;audio-beat-detection;159;127;127;180;128;127;129;128;153;126 09:41:46 INFO - PROCESS | 21356 | |2;audio-dft;164;168;166;167;169;164;164;163;164;163 09:41:46 INFO - PROCESS | 21356 | |3;audio-fft;76;76;75;104;76;76;76;76;109;76 09:41:46 INFO - PROCESS | 21356 | |4;audio-oscillator;88;82;119;83;83;82;98;82;84;108 09:41:46 INFO - PROCESS | 21356 | |5;imaging-gaussian-blur;118;118;117;117;118;118;123;117;118;118 09:41:46 INFO - PROCESS | 21356 | |6;imaging-darkroom;147;147;147;147;147;147;147;148;148;147 09:41:46 INFO - PROCESS | 21356 | |7;imaging-desaturate;97;96;98;96;96;96;96;98;98;96 09:41:46 INFO - PROCESS | 21356 | |8;json-parse-financial;53;53;61;54;56;58;56;54;54;54 09:41:46 INFO - PROCESS | 21356 | |9;json-stringify-tinderbox;63;63;64;63;64;63;63;70;63;63 09:41:46 INFO - PROCESS | 21356 | |10;stanford-crypto-aes;81;80;82;81;81;81;81;80;80;81 09:41:46 INFO - PROCESS | 21356 | |11;stanford-crypto-ccm;136;151;135;161;134;136;134;137;178;141 09:41:46 INFO - PROCESS | 21356 | |12;stanford-crypto-pbkdf2;173;172;171;170;167;176;174;170;170;167 09:41:46 INFO - PROCESS | 21356 | |13;stanford-crypto-sha256-iterative;65;66;65;68;67;65;65;63;65;65 09:41:46 INFO - PROCESS | 21356 | __end_tp_report 09:41:46 INFO - PROCESS | 21356 | __start_cc_report 09:41:46 INFO - PROCESS | 21356 | _x_x_mozilla_cycle_collect,827 09:41:46 INFO - PROCESS | 21356 | __end_cc_report 09:41:46 INFO - PROCESS | 21356 | __startTimestamp1479231706660__endTimestamp 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | ------- Summary: start ------- 09:41:46 INFO - PROCESS | 21356 | Number of tests: 14 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:2.83 (2.5%) stddev-sans-first:0.88 09:41:46 INFO - PROCESS | 21356 | Values: 104.0 112.0 113.0 112.0 114.0 111.0 112.0 113.0 113.0 113.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:128.50 stddev:18.90 (14.7%) stddev-sans-first:18.52 09:41:46 INFO - PROCESS | 21356 | Values: 159.0 127.0 127.0 180.0 128.0 127.0 129.0 128.0 153.0 126.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:2.15 (1.3%) stddev-sans-first:2.24 09:41:46 INFO - PROCESS | 21356 | Values: 164.0 168.0 166.0 167.0 169.0 164.0 164.0 163.0 164.0 163.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:12.97 (17.1%) stddev-sans-first:13.57 09:41:46 INFO - PROCESS | 21356 | Values: 76.0 76.0 75.0 104.0 76.0 76.0 76.0 76.0 109.0 76.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:13.13 (15.8%) stddev-sans-first:13.88 09:41:46 INFO - PROCESS | 21356 | Values: 88.0 82.0 119.0 83.0 83.0 82.0 98.0 82.0 84.0 108.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.75 (1.5%) stddev-sans-first:1.86 09:41:46 INFO - PROCESS | 21356 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 123.0 117.0 118.0 118.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 09:41:46 INFO - PROCESS | 21356 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 148.0 148.0 147.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:1.00 09:41:46 INFO - PROCESS | 21356 | Values: 97.0 96.0 98.0 96.0 96.0 96.0 96.0 98.0 98.0 96.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.54 (4.6%) stddev-sans-first:2.55 09:41:46 INFO - PROCESS | 21356 | Values: 53.0 53.0 61.0 54.0 56.0 58.0 56.0 54.0 54.0 54.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:63.00 stddev:2.18 (3.5%) stddev-sans-first:2.29 09:41:46 INFO - PROCESS | 21356 | Values: 63.0 63.0 64.0 63.0 64.0 63.0 63.0 70.0 63.0 63.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 09:41:46 INFO - PROCESS | 21356 | Values: 81.0 80.0 82.0 81.0 81.0 81.0 81.0 80.0 80.0 81.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:139.00 stddev:14.76 (10.6%) stddev-sans-first:15.34 09:41:46 INFO - PROCESS | 21356 | Values: 136.0 151.0 135.0 161.0 134.0 136.0 134.0 137.0 178.0 141.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:171.50 stddev:2.87 (1.7%) stddev-sans-first:2.95 09:41:46 INFO - PROCESS | 21356 | Values: 173.0 172.0 171.0 170.0 167.0 176.0 174.0 170.0 170.0 167.0 09:41:46 INFO - PROCESS | 21356 | 09:41:46 INFO - PROCESS | 21356 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.42 09:41:46 INFO - PROCESS | 21356 | Values: 65.0 66.0 65.0 68.0 67.0 65.0 65.0 63.0 65.0 65.0 09:41:46 INFO - PROCESS | 21356 | -------- Summary: end -------- 09:41:46 INFO - PROCESS | 21356 | 09:41:47 INFO - TEST-INFO | 21356: exit 0 09:41:47 INFO - TEST-OK | kraken | took 62758ms 09:41:47 INFO - SUITE-END | took 1178s 09:41:47 INFO - Completed test suite (00:19:39) 09:41:47 INFO - javascript benchmark 09:41:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7034.285059641961, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.9073327800165, 3098.0860646109395, 3122.843857807109, 3128.4368813613546, 3150.054983504949, 5284.920726189111, 5419.214213938976, 5485.424030476803, 5513.889722205554, 5519.9172012419795, 5331.360236771593, 5365.865853353668, 5443.237946687467, 5515.4760297771745, 5517.200005999138, 4828.299896515004, 4843.418789745236, 4928.334674818907, 4964.898169938536, 4981.576565991895, 4822.204336284509, 4887.951120488785, 4972.651914365996, 4987.47631498691, 5019.472955339692, 4751.524847515221, 4830.951690483085, 4901.8774530636665, 4958.752062396902, 4963.131451995904, 4876.097921884463, 4885.120678277908, 4885.462599114095, 4892.584130348924, 4898.0693668203285, 4803.03939212159, 4818.903621927542, 4836.637252206064, 4839.9032019359765, 4855.393075865517, 5331.093714068617, 5342.839714808562, 5387.218853266294, 5390.19147127934, 5437.510624043815, 5789.131630255453, 5801.680907550083, 5809.302883653946, 5812.360640329561, 5838.065909454509, 5538.335399752015, 5550.250716153308, 5797.478226959552, 5850.619709718854, 5855.912161317584, 5265.210218467222, 5282.947170528284, 5366.517013468807, 5385.407605163429, 5404.459554044564, 5885.499732522783, 5926.67403292823, 5935.584509084409, 5937.495312898365, 5975.133605627247, 5678.971605141948, 5693.089105743061, 5697.0, 5701.857453563694, 5707.771689132472, 5588.944110558842, 5646.378898321182, 5665.433456654301, 5670.979223739767, 5778.104393818965, 5741.138829175574, 5786.103154011135, 5792.189093526909, 5827.533797296206, 5887.61730487517, 5805.970970145122, 5842.561807864342, 5846.0, 5853.063509838491, 5853.356130825606, 4277.0, 4339.609435150852, 4458.331250312479, 4500.887477813016, 4535.070310586388, 3882.902927426837, 3902.180542086137, 3903.2583809076755, 3914.393269043303, 3933.331333673282, 5531.253280807039, 5531.972340138354, 5536.584756143306, 5542.418046105182, 5595.020871347498, 5849.707514624251, 5862.0, 5864.325602555676, 5867.471927526543, 5870.559708021916, 5287.735613219324, 5293.867653308698, 5355.410904800468, 5523.392426833045, 5538.695371754592, 4915.066137433876, 4924.803007879645, 4930.359053323117, 4939.678920870132, 4973.577245934136, 6003.5797494174985, 6057.878842423127, 6063.6664983426335, 6078.665673387918, 6104.816855494342, 5819.82540523785, 5831.446012628793, 5834.883302333845, 5838.357780644041, 5840.737166827588, 5854.619449735754, 5867.647941123376, 5932.288125424977, 5964.642121472725, 6047.274327080779, 5657.660540367591, 5702.7718891243885, 5712.314522257356, 5718.456746609066, 5723.084306510938, 5793.681347525927, 5837.970810145922, 5841.357450680337, 5884.0, 5894.145348924468, 5631.2960879890015, 5668.7165641718575, 5693.089105743061, 5699.51554117888, 5701.8859622806485, 5471.097268950738, 5628.409017053151, 5688.601797874109, 5705.800296989585, 5709.029464991045, 5589.189567512769, 5614.5789065821045, 5623.409541998195, 5636.4927156556105, 5668.886622267614, 5720.427957204246, 5749.683767392834, 5827.329857066492, 5834.591578589458, 5836.474717275296, 5639.0, 5651.0, 5691.943080569141, 5698.914516282176, 5699.088145896637], "value": 5335.578183832314, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.739403571375, 583.2854752927664, 592.0054308761285, 601.1673831743035, 602.8975074237379, 41032.17935641285, 43115.0, 43144.60692413448, 46183.30725039127, 46335.53664463355, 43914.7804260979, 44304.556954430445, 44413.0, 44509.109817803626, 44548.88627784307, 8648.870266945985, 8701.17338852808, 8701.869471957894, 8720.084391138935, 8787.428817126898, 8616.00915894674, 8674.739757807245, 8696.739097827076, 8731.126887311282, 8768.473891566495, 8657.177568131048, 8691.130886911322, 8727.170918762738, 8761.386702930797, 8804.471731696087, 8658.653653853902, 8688.174623410765, 8700.695475658385, 8702.30381569476, 8714.389992700513, 8437.451565648213, 8481.321494280442, 8509.191626795444, 8535.317174626016, 8563.743087707378, 39715.60284397177, 40135.39796903049, 40437.59562404368, 40551.188976220605, 40620.18759624791, 3401.132711158639, 3653.598104208535, 3723.441483777428, 3889.436031775405, 4030.5163380394542, 30478.695213047806, 30564.54153187704, 30659.540106898414, 30863.537046944315, 31089.844550777103, 4132.421460995463, 4160.729552579072, 4220.78896055196, 4233.23801715691, 4282.207791558571, 330486.0, 333268.0, 336789.0, 337515.0, 340272.9999999975, 56175.0, 56637.433625663216, 56846.7157664209, 56876.431235687116, 56883.43116568864, 61627.38372616306, 62024.37975620276, 62073.37926620767, 62211.0, 62314.0, 16469.258883350278, 16513.100993385673, 16555.66888662244, 16558.923669961656, 16719.0, 11995.580154694544, 12114.333711645768, 12168.452419641137, 12185.0, 12247.081468889868, 17553.473395798148, 18265.0, 18389.448316550526, 18477.1685274163, 18533.90733046353, 6944.583325000516, 7138.39323657495, 7221.386182174574, 7240.855182896313, 7286.380657644159, 922.4557511068501, 1073.5222825842425, 1077.9514921828536, 1085.8099832529276, 1099.290957332516, 31568.526472102938, 31589.0, 31639.841800790848, 32005.559749811313, 32024.83987580094, 1039.3504059962524, 1052.310736467615, 1069.8823129455754, 1133.2747041893194, 1180.6340034589305, 16507.504774856774, 16949.742274446755, 17118.315267389415, 17143.0, 17162.970221786734, 501033.0, 503387.0, 505058.0, 506747.0, 506807.0, 56455.0, 56480.717596411756, 56870.0, 56986.0, 57084.143737843966, 1259.175240217659, 1326.4296352568294, 1330.155351351879, 1330.5409633676366, 1342.9462821487227, 30023.54964675488, 31285.74857005694, 31979.36041279208, 32075.67924320727, 32253.838730807136, 50119.0, 50572.0, 50654.493455066455, 50715.364080824525, 50775.492245077075, 418655.0, 418822.0, 419230.0, 419470.0, 419636.0, 28168.29579260535, 28218.576721349607, 28268.293292667026, 28304.43391132207, 28572.142835714963, 44677.329840051774, 45153.0, 45651.31523027224, 46122.0, 47019.294710580056, 38282.80858595689, 38524.80737596406, 38795.61204388033, 38945.0, 40893.79553102215, 39584.60415395924, 39597.40603890886, 40060.94807006018, 40172.598274016884, 41256.0, 34971.0, 35054.47418288779, 38994.80502597469, 40588.1882362357, 40803.59196408117, 32912.67087329096, 36073.63926360703, 36143.638563614026, 36548.26903461863, 36735.0, 27134.0, 27449.17652470429, 27470.450590987668, 27818.0, 27974.764852039807], "value": 19711.506443775528, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.476322674709, 386.8781333879826, 398.76871414579546, 399.41685139696045, 417.7201275145652, 17802.910985445087, 19315.517112072204, 19326.42020739378, 19341.419757407264, 19459.708104378446, 18800.905995470002, 18823.0, 19074.332398366027, 19133.61732765344, 19259.614807703838, 5415.214793854889, 5425.511703946644, 5559.277293951781, 5596.748146333404, 5665.8583535411735, 5463.453654634544, 5599.628091117682, 5600.8319750407345, 5605.495505404513, 5616.101423772197, 5435.347758269013, 5495.587830912677, 5558.555315574765, 5715.9997000524945, 5745.109508026263, 5771.797987070453, 5803.042497987827, 5811.3316968548315, 5830.125481177814, 5832.387599302076, 5401.864953376158, 5642.830715078554, 5644.209810626516, 5682.914756278659, 5690.0, 12158.635240942785, 12212.511499540096, 12285.324307163102, 21031.78968210329, 21941.670874936888, 2167.8157356624706, 2208.1719355241785, 2320.640300753386, 2384.0582969727034, 2646.8676566171616, 9915.405075695482, 10130.290879638429, 10377.377357358582, 10812.35125892449, 10858.185636077247, 1771.8394451634201, 1795.5152108930515, 1831.7252412138153, 1837.1549087419803, 1915.5689969756831, 83965.0, 88073.55963220143, 89051.55474222652, 90018.5499072507, 90167.54916225377, 11024.724381890357, 11117.666470005752, 11128.777424451628, 11306.434678266054, 11365.886341136647, 15544.76682849758, 15628.0, 15686.686266274839, 15730.0, 15739.921300393426, 7909.485883417559, 8063.717769878026, 8087.676492940216, 8191.713290034821, 8357.749267521984, 7647.732329368446, 7701.345385642171, 7914.525128492309, 7963.641636126388, 8052.355811535063, 4603.401557797465, 4792.592629626451, 4800.039842621659, 4846.418429788448, 4865.416150061945, 1887.045699713151, 2015.4256037029377, 2018.2835093541876, 2024.321852179507, 2047.5802460495563, 901.2114399900088, 927.5779520318239, 938.5635679409107, 959.3811991265594, 979.9853002204973, 18375.356862509747, 19136.521586960436, 19380.806191938183, 19446.513837154183, 19760.209591616174, 931.2131249094505, 941.9623215071321, 954.6372378496127, 973.4208146153028, 1012.5797793915442, 10711.571537138427, 10765.008473432441, 10966.342019478856, 11007.834882476769, 11094.611688590861, 420282.0, 450560.0, 463309.0, 463322.0, 463567.0, 86579.56710216409, 91181.0, 91281.54359228293, 91406.54296728474, 91877.0, 953.7758626722576, 956.168133723651, 987.5950860147306, 995.8149801735912, 996.3324572536418, 16620.335186592885, 16905.746413803558, 17188.0, 17340.47978560645, 17495.737563936298, 42136.57863421326, 42615.57384426116, 42716.35925461183, 42938.0, 43185.35221971736, 56574.71712641411, 57355.0, 57504.71247643735, 58263.0, 58741.0, 8147.83704325922, 8183.140770219279, 8324.875126872981, 8338.291245244221, 8378.832423351621, 10925.344479331265, 12239.938800306298, 12258.509659613872, 12621.116521843383, 12875.098743087894, 10701.678949631523, 10850.131989440668, 10910.563577456813, 11030.117590592894, 11154.832677510007, 10573.312734672221, 10602.575896964343, 10760.515776789907, 10958.123350131811, 11085.334879907232, 10909.454527273763, 11045.944770276097, 11087.22389432732, 11148.665540033811, 11343.773124537629, 7209.6034718091005, 7693.269139431745, 7703.3067023968115, 8274.0, 8385.16148385181, 8663.653453861774, 10801.837972430263, 11185.38480383554, 11608.767824643292, 11673.941630291794], "value": 8965.079849073643, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.2905211920095, 1447.6887469194126, 1585.563969908275, 1688.9746653800203, 1707.257343055771, 7496.625168741569, 7760.534367937914, 7968.442209045369, 8416.915830841697, 8498.787530311745, 7883.8423231535335, 8219.260266576008, 8246.793830154249, 8432.241098301152, 8441.282490988273, 2291.564602725481, 2318.2813327868416, 2320.969151992007, 2325.802306803915, 2329.0683726509446, 2313.144136669435, 2324.5583339165587, 2371.3834403055243, 2371.9169829055986, 2373.95252094958, 2282.7260728712495, 2286.1084177170915, 2290.530441259538, 2302.7236731592147, 2317.2700599311247, 2192.090282532747, 2205.4045407739823, 2214.5570885822817, 2217.977820221793, 2222.388843068153, 2198.8350873684376, 2199.6590528468114, 2205.128974055255, 2214.7895949884737, 2216.0581752755015, 8374.41379103463, 8462.0, 8492.53291068991, 8515.616797244138, 8531.74404767858, 4961.404631444214, 5048.62135339851, 5102.413222479388, 5104.795808167669, 5111.0, 3101.9689803101905, 3242.610886693612, 3396.932061358759, 3430.9142271443166, 3432.0, 1063.882972872991, 1086.9130469562494, 1092.3500517192258, 1097.742030622803, 1137.6473293279028, 11160.16298777595, 11161.772205057438, 11182.944085279685, 11222.831657525143, 11246.887531124748, 4374.147041326911, 4424.269995450779, 4464.910701785946, 4491.393661855608, 4648.58162765346, 9752.46361450127, 9871.111599955895, 9886.604535818631, 9918.454485003249, 9919.80160396788, 5170.405403378584, 5171.4311425743135, 5172.353455818023, 5174.586033117342, 5196.870078247998, 4557.567031132104, 4639.582437580634, 4709.858704238878, 4741.5021422750115, 4742.881427964328, 3539.663731945461, 3662.6520480554304, 3680.429533422324, 3685.4656074868994, 3702.777833330009, 1174.5686429091697, 1200.3098218524383, 1200.3458115326994, 1202.8556573211097, 1213.2832042659538, 742.4246209187922, 853.1298075962484, 902.1069141549818, 923.2844545477309, 923.2844545477309, 5612.831615051555, 5636.126400407943, 5667.489925906606, 5777.711114444261, 5931.4958228550195, 408.81807595619665, 423.24239611095794, 429.3645404800912, 430.6232046958911, 430.7544699521243, 3868.8200098969523, 4021.376686613521, 4032.9596704032583, 4046.959530404717, 4149.33610622299, 10035.197184225244, 10262.179025678077, 10390.428526430967, 10451.529681164366, 10454.163666906628, 10241.94879025615, 10257.692269231935, 10381.0, 10392.064714175609, 10402.219833512365, 7662.73180438682, 7878.487898286593, 7907.644156012993, 7916.129225785159, 7921.722739704198, 5474.5894057945015, 5531.3362396512675, 5555.250041244381, 5576.665400076008, 5641.533201367756, 9335.906640933505, 9435.858462123211, 9459.479728614991, 9509.239260858976, 9519.286053545873, 9081.318901082577, 9511.334206605472, 9523.23814094857, 9728.17310528613, 9740.0, 7231.240719724353, 7446.25537446251, 7496.812579685334, 7525.58609276495, 7561.432892532972, 8236.888020117207, 8314.750557483285, 8333.916660833314, 8397.118302578141, 8398.286145677686, 6868.896966545406, 6912.135983002125, 7094.9290507094265, 7423.665935032828, 7655.0, 7049.436045116276, 7095.645217739196, 7122.216556178712, 7144.214136445091, 7335.596542190231, 6511.772087976898, 6587.703553340016, 6629.773491904013, 6651.667416629246, 6659.500537459613, 5035.118854200574, 5120.436751957207, 5186.377634683862, 5280.656757310762, 5313.601479888946, 4880.92678609814, 5045.823396181116, 5050.141475949171, 5213.973930130325, 5265.183511688461], "value": 4358.438420061646, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.2097403309956, 330.41516515767086, 336.9898903032909, 338.96610338966104, 339.52466546834444, 5447.618666693333, 5502.422245664207, 5529.419410961847, 5555.0, 5576.33084029916, 5377.247185394048, 5430.859519500909, 5431.809886653958, 5502.119660854264, 5507.146392309199, 3986.5614782373914, 4075.4498142750645, 4117.60882716143, 4146.502419709639, 4188.916221675565, 4156.646685031776, 4175.976885663017, 4183.728057676257, 4192.601702838226, 4217.6891140454745, 4143.212789569987, 4179.164167166564, 4179.477565304337, 4185.414042034103, 4193.245215861144, 4110.753354798707, 4149.2531344358, 4169.791510424497, 4202.70581059326, 4208.905684522031, 3693.815309234554, 3717.7211709121925, 3722.8883133506038, 3723.6222597638775, 3740.3080430120244, 5259.184826351883, 5269.0, 5302.3637163540625, 5308.867278318035, 5332.466753324637, 4694.835680751157, 4844.75776211188, 4859.708417494961, 4862.854114376539, 4863.392075990501, 5622.184783206412, 5624.690642014688, 5636.408177141382, 5638.618538458063, 5666.951613951433, 4142.91714165715, 4156.231097247019, 4160.479940007499, 4180.979095104505, 4191.91616167675, 5567.3040869891265, 5763.9135412968835, 5847.707614619295, 5949.524038076944, 5959.821205363846, 4016.5983401660183, 4030.173814368106, 4032.7700051483994, 4048.7975601219823, 4083.714140010171, 4096.692748043909, 4100.487439070116, 4108.6918481114035, 4136.2968295389255, 4142.896427589274, 4610.7781437918975, 4723.7401942893475, 4736.455307639597, 4750.572448479654, 4775.498572649822, 5628.0, 5639.774409023676, 5642.971785141131, 5661.688607126565, 5675.2054712340305, 1390.8122403475604, 1405.276282714403, 1415.2569900802162, 1417.3905220755175, 1419.929003549839, 932.3566738950238, 953.9458897917701, 963.629002833914, 981.8625392445064, 984.6307634637011, 5144.588432925357, 5213.218017297359, 5227.895442091137, 5265.183896496049, 5309.761060752276, 5586.413426590231, 5604.85987850307, 5631.211630371751, 5670.347909990404, 5670.716464176775, 5120.206368012964, 5266.762995665128, 5267.841964740987, 5333.173358129496, 5399.406065332889, 2954.763618910482, 2999.710124646423, 3014.276573622315, 3017.2456885778556, 3019.8222693149687, 5859.736311865976, 5903.793367232126, 5918.0, 5921.940780592139, 5936.111846740392, 5532.972335138298, 5681.687507187145, 5741.971290143522, 5746.0, 5756.65460072397, 5844.853878653068, 5863.296404431496, 5869.358788545086, 5871.236739223874, 5902.940970590239, 5485.561155107662, 5709.429057094258, 5723.651663776737, 5726.570507212059, 5812.169166712472, 5803.15645333775, 5806.390329015392, 5810.477057064884, 5818.44724751148, 5851.180834683063, 6068.78759243442, 6078.908816367846, 6094.481969032505, 6110.236220472441, 6114.174586430953, 4041.2725709372594, 4202.285611446123, 4233.153369326209, 4233.597808208216, 4248.87253382399, 5782.653040817564, 5841.853953651193, 5843.415658434123, 5863.214972887844, 5895.911561326498, 5539.861503462445, 5706.914396284142, 5740.741666625096, 5754.741036653444, 5797.782465682254, 5642.379338272704, 5650.0, 5654.46282603152, 5657.331087329166, 5678.403767604342, 5574.442555744393, 5577.888442231051, 5617.354004289559, 5618.438156184349, 5654.575906806924, 5498.725063746877, 5704.3725190228215, 5718.685472298897, 5723.394261615156, 5749.626274292157, 5580.302462192226, 5582.27430434041, 5593.1263026886445, 5614.624417017857, 5620.241267428844], "value": 4296.3515769292735, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.5090285897013, 725.8838585826269, 727.2799928071208, 792.6433105102706, 797.8922845415867, 12826.935865320673, 13545.322733863317, 13612.251326177056, 13663.521776737816, 13681.726365472685, 9864.802703945918, 13209.273489958048, 13406.195628262287, 13419.932900335485, 13428.060035797498, 657.447743895128, 767.3209209849296, 785.7446329942763, 789.6643926331315, 790.6521130702472, 759.3773106053038, 769.7690692792168, 772.1352085664064, 773.5281478298234, 774.0827119862952, 831.4138532334689, 833.62903507939, 838.5597561280316, 839.630562552478, 840.1178762299561, 827.0406328658758, 833.5957060825494, 834.1783343406739, 835.6156168162653, 837.3385025829588, 611.0101635350716, 611.5321778839192, 612.3233826621564, 612.4151435379247, 613.1262950295855, 12353.258804471761, 12355.32045737493, 12693.11148219625, 12694.619161425171, 12698.0, 13446.0, 13569.796453053212, 14269.286535673175, 14279.714405711931, 14426.783598246035, 10993.311053397338, 11564.42177891102, 11572.0, 11655.941720291345, 11827.704307392298, 3493.598236202844, 3557.5730912290433, 3557.964420355789, 3591.712662986955, 3604.6395360464007, 62457.68771156161, 62599.68700156516, 62884.68557657228, 63103.6844815773, 64095.0, 10377.792444151075, 10483.580656773796, 10663.507109004746, 10878.619248326271, 10951.33182485809, 19298.0, 19452.0, 19557.413277601696, 19920.601587968158, 20206.29277975264, 7639.465237433437, 7717.614119294013, 7792.961035194788, 7857.371410287164, 7919.802004949807, 4377.190219809346, 4453.242948698729, 4462.509123996423, 4518.164139634178, 4568.954310456919, 3355.0, 3418.025862629139, 3428.8971330860113, 3482.8258587070545, 3483.7038851697384, 568.3492401200602, 578.5400606517828, 628.6228263042138, 629.3486241739778, 675.3719041291548, 702.2977022977022, 712.3482013957171, 729.0194688144437, 738.8522295540806, 744.2334395572569, 8039.557824319601, 8075.959620201861, 8278.793030174173, 8284.337253019745, 8605.182507661762, 571.012148982263, 650.2489624483729, 668.0513670587777, 715.996420017907, 736.131364989307, 3948.0129967508124, 4068.1863627274665, 4134.37984302351, 4163.937540936889, 4183.142455796555, 53584.0, 53835.19247211295, 63058.0, 90468.0, 90606.54696726475, 77510.6124469374, 78899.60550197212, 78923.84253970809, 79124.6043769789, 80860.78708819373, 67754.82045462543, 69590.0, 69661.65169174223, 71934.0, 73612.63193683997, 7715.0, 7929.207079292025, 8027.598620068857, 8396.0, 8662.0, 43506.56493435025, 44995.0, 45467.772661136485, 47291.763541182074, 47379.28931066106, 60563.39436605578, 61847.0, 63003.36996629975, 63838.68080659567, 64327.67836160789, 12003.75992480163, 12282.631521054383, 12439.689007774878, 12572.685682858002, 12711.682207944876, 13348.0, 13875.167489950636, 14084.929575352058, 14217.679634913733, 14531.564053078424, 11841.46713397882, 11991.400429978292, 12047.216930899463, 12049.277043377426, 12586.370681466073, 13490.448598411309, 13627.727445451234, 13984.091034082752, 14371.353289101806, 14406.567802965928, 11211.271267367594, 11435.714107147054, 11548.769024619629, 11766.235194712317, 12105.273683579013, 10198.337108088248, 10402.47987600632, 10410.947945260225, 10475.58097676115, 10763.300385474919, 10231.795364092824, 10522.21083418762, 10749.731256718645, 10865.945670271914, 10871.184661150288], "value": 6861.01138863469, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 112.0, 114.0, 111.0, 112.0, 113.0, 113.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 127.0, 127.0, 180.0, 128.0, 127.0, 129.0, 128.0, 153.0, 126.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 166.0, 167.0, 169.0, 164.0, 164.0, 163.0, 164.0, 163.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 104.0, 76.0, 76.0, 76.0, 76.0, 109.0, 76.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 119.0, 83.0, 83.0, 82.0, 98.0, 82.0, 84.0, 108.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 123.0, 117.0, 118.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 98.0, 98.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 61.0, 54.0, 56.0, 58.0, 56.0, 54.0, 54.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 63.0, 70.0, 63.0, 63.0], "value": 63.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 82.0, 81.0, 81.0, 81.0, 81.0, 80.0, 80.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 151.0, 135.0, 161.0, 134.0, 136.0, 134.0, 137.0, 178.0, 141.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 172.0, 171.0, 170.0, 167.0, 176.0, 174.0, 170.0, 170.0, 167.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 68.0, 67.0, 65.0, 65.0, 63.0, 65.0, 65.0], "value": 65.4, "unit": "score"}]}]} 09:41:47 INFO - Return code: 0 09:41:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:41:47 ERROR - # TBPL SUCCESS # 09:41:47 INFO - Running post-action listener: _resource_record_post_action 09:41:47 INFO - [mozharness: 2016-11-15 17:41:47.948528Z] Finished run-tests step (success) 09:41:47 INFO - Running post-run listener: _resource_record_post_run 09:41:48 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409608192; Read time: 4; Write time: 294856 09:41:48 INFO - TinderboxPrint: CPU usage
13.4% 09:41:48 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 09:41:48 INFO - TinderboxPrint: I/O write bytes / time
409,608,192 / 294,856 09:41:48 INFO - TinderboxPrint: CPU idle
8,257.2 (86.6%) 09:41:48 INFO - TinderboxPrint: CPU user
1,217.6 (12.8%) 09:41:48 INFO - TinderboxPrint: Swap in / out
0 / 0 09:41:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 120573952; Read time: 0; Write time: 79920 09:41:48 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288681984; Read time: 0; Write time: 214932 09:41:48 INFO - Running post-run listener: _upload_blobber_files 09:41:48 INFO - Blob upload gear active. 09:41:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:41:48 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 09:41:48 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-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:41:48 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-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:41:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:41:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:41:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:52 INFO - (blobuploader) - INFO - Done attempting. 09:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:41:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:52 INFO - (blobuploader) - INFO - Done attempting. 09:41:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:41:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:41:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:41:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:41:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:41:53 INFO - (blobuploader) - INFO - Done attempting. 09:41:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:41:53 INFO - Return code: 0 09:41:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:41:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:41:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1244105e2d97f5eb1b1f43df106c0dbbe0fc6a274dec66a94e94c51a8df2249a74b8731654195d28d21d7f7cc60f5d6cdbee63ce8419c2249ad666a06f733946", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce3f1d656a402bdc69e1b57c2a9eda47ec093fe9ed9375734d31f5639c37571d359b7766d2db2bbaac5ee71e4db812d953053b38e42e0d0bff5238375a84973a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41ddce34a87ca0ec38d0f84c93613f5c5312ad36c67000bd847eb8562e1ea3943f602604e9cf5d94d8f196970cf7dd3462e78a0f9673e6f5711b49b98953b1e"} 09:41:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:41:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:41:53 INFO - Contents: 09:41:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1244105e2d97f5eb1b1f43df106c0dbbe0fc6a274dec66a94e94c51a8df2249a74b8731654195d28d21d7f7cc60f5d6cdbee63ce8419c2249ad666a06f733946", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce3f1d656a402bdc69e1b57c2a9eda47ec093fe9ed9375734d31f5639c37571d359b7766d2db2bbaac5ee71e4db812d953053b38e42e0d0bff5238375a84973a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41ddce34a87ca0ec38d0f84c93613f5c5312ad36c67000bd847eb8562e1ea3943f602604e9cf5d94d8f196970cf7dd3462e78a0f9673e6f5711b49b98953b1e"} 09:41:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:41:53 INFO - Copying logs to upload dir... 09:41:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:41:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.591661 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-15 09:41:53.171685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 09:41:53.175120) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942 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-Inbound/sha512/1244105e2d97f5eb1b1f43df106c0dbbe0fc6a274dec66a94e94c51a8df2249a74b8731654195d28d21d7f7cc60f5d6cdbee63ce8419c2249ad666a06f733946", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce3f1d656a402bdc69e1b57c2a9eda47ec093fe9ed9375734d31f5639c37571d359b7766d2db2bbaac5ee71e4db812d953053b38e42e0d0bff5238375a84973a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41ddce34a87ca0ec38d0f84c93613f5c5312ad36c67000bd847eb8562e1ea3943f602604e9cf5d94d8f196970cf7dd3462e78a0f9673e6f5711b49b98953b1e"} build_url:https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011681 build_url: 'https://queue.taskcluster.net/v1/task/XvLUGgQTQ5CK-pXHF9CtDw/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/1244105e2d97f5eb1b1f43df106c0dbbe0fc6a274dec66a94e94c51a8df2249a74b8731654195d28d21d7f7cc60f5d6cdbee63ce8419c2249ad666a06f733946", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ce3f1d656a402bdc69e1b57c2a9eda47ec093fe9ed9375734d31f5639c37571d359b7766d2db2bbaac5ee71e4db812d953053b38e42e0d0bff5238375a84973a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/c41ddce34a87ca0ec38d0f84c93613f5c5312ad36c67000bd847eb8562e1ea3943f602604e9cf5d94d8f196970cf7dd3462e78a0f9673e6f5711b49b98953b1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 09:41:53.201355) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:41:53.201717) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8c6b6742ce8f6f39ef4ce27d000001f1-1479230280.2124-1746881942 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004684 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:41:53.287624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 09:41:53.288010) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 09:41:53.288328) ========= ========= Total master_lag: 0.18 =========